builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1465484169.45 results: success (0) buildid: 20160609063930 builduid: d0802cb2d96b4ba2a2c38a875633f351 revision: f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.445732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.446612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.447308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.465893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.466594) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 07:56:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-06-09 07:56:09 (14.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.603967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.604268) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:09.652788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 07:56:09.653101) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 07:56:09,752 truncating revision to first 12 chars 2016-06-09 07:56:09,753 Setting DEBUG logging. 2016-06-09 07:56:09,753 attempt 1/10 2016-06-09 07:56:09,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8e3b81a79f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 07:56:10,728 unpacking tar archive at: mozilla-central-f8e3b81a79f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308644 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 07:56:10.975145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:10.975482) ========= script_repo_revision: f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:10.975862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:10.976130) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 07:56:10.985387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-09 07:56:10.985679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:56:11 INFO - MultiFileLogger online at 20160609 07:56:11 in /builds/slave/test 07:56:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:56:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:11 INFO - {'append_to_log': False, 07:56:11 INFO - 'base_work_dir': '/builds/slave/test', 07:56:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:56:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:11 INFO - 'branch': 'Firefox-Non-PGO', 07:56:11 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:11 INFO - 'config_files': ('talos/linux_config.py',), 07:56:11 INFO - 'default_actions': ('clobber', 07:56:11 INFO - 'read-buildbot-config', 07:56:11 INFO - 'download-and-extract', 07:56:11 INFO - 'populate-webroot', 07:56:11 INFO - 'create-virtualenv', 07:56:11 INFO - 'install', 07:56:11 INFO - 'run-tests'), 07:56:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:11 INFO - 'download_minidump_stackwalk': True, 07:56:11 INFO - 'download_symbols': 'ondemand', 07:56:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:11 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:11 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:11 INFO - 'installer_path': 'installer.exe', 07:56:11 INFO - 'log_level': 'info', 07:56:11 INFO - 'log_name': 'talos', 07:56:11 INFO - 'log_to_console': True, 07:56:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:56:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:56:11 INFO - 'opt_config_files': (), 07:56:11 INFO - 'pip_index': False, 07:56:11 INFO - 'sps_profile': False, 07:56:11 INFO - 'sps_profile_interval': 0, 07:56:11 INFO - 'suite': 'dromaeojs', 07:56:11 INFO - 'system_bits': '32', 07:56:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:11 INFO - 'title': 'talos-linux64-ix-004', 07:56:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:11 INFO - 'use_talos_json': True, 07:56:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:11 INFO - 'work_dir': 'build'} 07:56:11 INFO - ##### 07:56:11 INFO - ##### Running clobber step. 07:56:11 INFO - ##### 07:56:11 INFO - Running pre-action listener: _resource_record_pre_action 07:56:11 INFO - Running main action method: clobber 07:56:11 INFO - rmtree: /builds/slave/test/build 07:56:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:11 INFO - Running post-action listener: _resource_record_post_action 07:56:11 INFO - ##### 07:56:11 INFO - ##### Finished clobber step (success) 07:56:11 INFO - ##### 07:56:11 INFO - ##### 07:56:11 INFO - ##### Running read-buildbot-config step. 07:56:11 INFO - ##### 07:56:11 INFO - Running pre-action listener: _resource_record_pre_action 07:56:11 INFO - Running main action method: read_buildbot_config 07:56:11 INFO - Using buildbot properties: 07:56:11 INFO - { 07:56:11 INFO - "project": "", 07:56:11 INFO - "product": "firefox", 07:56:11 INFO - "script_repo_revision": "production", 07:56:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:56:11 INFO - "repository": "", 07:56:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:56:11 INFO - "buildid": "20160609063930", 07:56:11 INFO - "pgo_build": "False", 07:56:11 INFO - "basedir": "/builds/slave/test", 07:56:11 INFO - "buildnumber": 526, 07:56:11 INFO - "slavename": "talos-linux64-ix-004", 07:56:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:56:11 INFO - "platform": "ubuntu64_hw", 07:56:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:56:11 INFO - "branch": "mozilla-central", 07:56:11 INFO - "repo_path": "mozilla-central", 07:56:11 INFO - "revision": "f8e3b81a79f45ef8647c98281a9a00d1ddb28b73", 07:56:11 INFO - "stage_platform": "linux64", 07:56:11 INFO - "builduid": "d0802cb2d96b4ba2a2c38a875633f351", 07:56:11 INFO - "slavebuilddir": "test" 07:56:11 INFO - } 07:56:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:56:11 INFO - Running post-action listener: _resource_record_post_action 07:56:11 INFO - ##### 07:56:11 INFO - ##### Finished read-buildbot-config step (success) 07:56:11 INFO - ##### 07:56:11 INFO - ##### 07:56:11 INFO - ##### Running download-and-extract step. 07:56:11 INFO - ##### 07:56:11 INFO - Running pre-action listener: _resource_record_pre_action 07:56:11 INFO - Running main action method: download_and_extract 07:56:11 INFO - mkdir: /builds/slave/test/build/tests 07:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:11 INFO - https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:56:12 INFO - Downloaded 1361 bytes. 07:56:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:12 INFO - Using the following test package requirements: 07:56:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:56:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:56:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'jsshell-linux-x86_64.zip'], 07:56:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:56:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:56:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:56:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:56:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:56:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:12 INFO - https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:13 INFO - Downloaded 22879571 bytes. 07:56:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:56:14 INFO - Return code: 0 07:56:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:14 INFO - https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:16 INFO - Downloaded 22879571 bytes. 07:56:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:56:18 INFO - Return code: 0 07:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:18 INFO - https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:56:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:56:18 INFO - Downloaded 10833377 bytes. 07:56:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:56:19 INFO - Return code: 0 07:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:19 INFO - https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:56:20 INFO - Downloaded 55433595 bytes. 07:56:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:20 INFO - mkdir: /builds/slave/test/properties 07:56:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:20 INFO - Contents: 07:56:20 INFO - build_url:https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:21 INFO - Running post-action listener: _resource_record_post_action 07:56:21 INFO - Running post-action listener: set_extra_try_arguments 07:56:21 INFO - ##### 07:56:21 INFO - ##### Finished download-and-extract step (success) 07:56:21 INFO - ##### 07:56:21 INFO - ##### 07:56:21 INFO - ##### Running populate-webroot step. 07:56:21 INFO - ##### 07:56:21 INFO - Running pre-action listener: _resource_record_pre_action 07:56:21 INFO - Running main action method: populate_webroot 07:56:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:21 INFO - '--tppagecycles', 07:56:21 INFO - '7'], 07:56:21 INFO - 'tests': ['tsvgm']}}, 07:56:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['damp', 'tps']}, 07:56:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['damp', 'tps']}, 07:56:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['dromaeo_dom']}, 07:56:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['a11yr', 07:56:21 INFO - 'ts_paint', 07:56:21 INFO - 'tpaint', 07:56:21 INFO - 'sessionrestore', 07:56:21 INFO - 'sessionrestore_no_auto_restore', 07:56:21 INFO - 'tabpaint']}, 07:56:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tsvgx', 07:56:21 INFO - 'tsvgr_opacity', 07:56:21 INFO - 'tart', 07:56:21 INFO - 'tscrollx', 07:56:21 INFO - 'cart']}, 07:56:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:21 INFO - 'tsvgr_opacity', 07:56:21 INFO - 'tart', 07:56:21 INFO - 'tscrollx', 07:56:21 INFO - 'cart']}, 07:56:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s'], 07:56:21 INFO - 'tests': ['tp5o']}, 07:56:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'tests': ['tp5o']}, 07:56:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--disable-e10s', 07:56:21 INFO - '--xperf_path', 07:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:21 INFO - 'tests': ['tp5n']}, 07:56:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:21 INFO - 'talos_options': ['--xperf_path', 07:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:21 INFO - 'tests': ['tp5n']}}, 07:56:21 INFO - 'talos.zip': {'path': '', 07:56:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:21 INFO - Running post-action listener: _resource_record_post_action 07:56:21 INFO - ##### 07:56:21 INFO - ##### Finished populate-webroot step (success) 07:56:21 INFO - ##### 07:56:21 INFO - ##### 07:56:21 INFO - ##### Running create-virtualenv step. 07:56:21 INFO - ##### 07:56:21 INFO - Running pre-action listener: _resource_record_pre_action 07:56:21 INFO - Running main action method: create_virtualenv 07:56:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:56:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:21 INFO - Using real prefix '/usr' 07:56:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:21 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:23 INFO - Installing pip.................done. 07:56:23 INFO - Return code: 0 07:56:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:56:23 INFO - Using env: {'DISPLAY': ':0', 07:56:23 INFO - 'HOME': '/home/cltbld', 07:56:23 INFO - 'LANG': 'en_US.UTF-8', 07:56:23 INFO - 'LANGUAGE': 'en_US:en', 07:56:23 INFO - 'LOGNAME': 'cltbld', 07:56:23 INFO - 'MAIL': '/var/mail/cltbld', 07:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:23 INFO - 'MOZ_NO_REMOTE': '1', 07:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:23 INFO - 'NO_EM_RESTART': '1', 07:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:23 INFO - 'PWD': '/builds/slave/test', 07:56:23 INFO - 'SHELL': '/bin/bash', 07:56:23 INFO - 'SHLVL': '1', 07:56:23 INFO - 'TERM': 'linux', 07:56:23 INFO - 'TMOUT': '86400', 07:56:23 INFO - 'USER': 'cltbld', 07:56:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:23 INFO - '_': '/tools/buildbot/bin/python'} 07:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:56:24 INFO - Cleaning up... 07:56:24 INFO - Return code: 0 07:56:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:56:24 INFO - Using env: {'DISPLAY': ':0', 07:56:24 INFO - 'HOME': '/home/cltbld', 07:56:24 INFO - 'LANG': 'en_US.UTF-8', 07:56:24 INFO - 'LANGUAGE': 'en_US:en', 07:56:24 INFO - 'LOGNAME': 'cltbld', 07:56:24 INFO - 'MAIL': '/var/mail/cltbld', 07:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:24 INFO - 'MOZ_NO_REMOTE': '1', 07:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:24 INFO - 'NO_EM_RESTART': '1', 07:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:24 INFO - 'PWD': '/builds/slave/test', 07:56:24 INFO - 'SHELL': '/bin/bash', 07:56:24 INFO - 'SHLVL': '1', 07:56:24 INFO - 'TERM': 'linux', 07:56:24 INFO - 'TMOUT': '86400', 07:56:24 INFO - 'USER': 'cltbld', 07:56:24 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:24 INFO - '_': '/tools/buildbot/bin/python'} 07:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:24 INFO - Downloading/unpacking psutil>=3.1.1 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:26 INFO - Installing collected packages: psutil 07:56:26 INFO - Running setup.py install for psutil 07:56:26 INFO - building 'psutil._psutil_linux' extension 07:56:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:56:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:56:26 INFO - building 'psutil._psutil_posix' extension 07:56:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:56:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:26 INFO - Successfully installed psutil 07:56:26 INFO - Cleaning up... 07:56:26 INFO - Return code: 0 07:56:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:56:26 INFO - Using env: {'DISPLAY': ':0', 07:56:26 INFO - 'HOME': '/home/cltbld', 07:56:26 INFO - 'LANG': 'en_US.UTF-8', 07:56:26 INFO - 'LANGUAGE': 'en_US:en', 07:56:26 INFO - 'LOGNAME': 'cltbld', 07:56:26 INFO - 'MAIL': '/var/mail/cltbld', 07:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:26 INFO - 'MOZ_NO_REMOTE': '1', 07:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:26 INFO - 'NO_EM_RESTART': '1', 07:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:26 INFO - 'PWD': '/builds/slave/test', 07:56:26 INFO - 'SHELL': '/bin/bash', 07:56:26 INFO - 'SHLVL': '1', 07:56:26 INFO - 'TERM': 'linux', 07:56:26 INFO - 'TMOUT': '86400', 07:56:26 INFO - 'USER': 'cltbld', 07:56:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:26 INFO - '_': '/tools/buildbot/bin/python'} 07:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:29 INFO - Installing collected packages: mozsystemmonitor 07:56:29 INFO - Running setup.py install for mozsystemmonitor 07:56:29 INFO - Successfully installed mozsystemmonitor 07:56:29 INFO - Cleaning up... 07:56:29 INFO - Return code: 0 07:56:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:56:29 INFO - Using env: {'DISPLAY': ':0', 07:56:29 INFO - 'HOME': '/home/cltbld', 07:56:29 INFO - 'LANG': 'en_US.UTF-8', 07:56:29 INFO - 'LANGUAGE': 'en_US:en', 07:56:29 INFO - 'LOGNAME': 'cltbld', 07:56:29 INFO - 'MAIL': '/var/mail/cltbld', 07:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:29 INFO - 'MOZ_NO_REMOTE': '1', 07:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:29 INFO - 'NO_EM_RESTART': '1', 07:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:29 INFO - 'PWD': '/builds/slave/test', 07:56:29 INFO - 'SHELL': '/bin/bash', 07:56:29 INFO - 'SHLVL': '1', 07:56:29 INFO - 'TERM': 'linux', 07:56:29 INFO - 'TMOUT': '86400', 07:56:29 INFO - 'USER': 'cltbld', 07:56:29 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:29 INFO - '_': '/tools/buildbot/bin/python'} 07:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:29 INFO - Downloading/unpacking jsonschema==2.5.1 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:32 INFO - warning: no files found matching '*.txt' 07:56:32 INFO - no previously-included directories found matching 'build' 07:56:32 INFO - no previously-included directories found matching 'dist' 07:56:32 INFO - no previously-included directories found matching '.git*' 07:56:32 INFO - Installing collected packages: jsonschema, functools32 07:56:32 INFO - Running setup.py install for functools32 07:56:32 INFO - warning: no files found matching '*.txt' 07:56:32 INFO - no previously-included directories found matching 'build' 07:56:32 INFO - no previously-included directories found matching 'dist' 07:56:32 INFO - no previously-included directories found matching '.git*' 07:56:32 INFO - Successfully installed jsonschema functools32 07:56:32 INFO - Cleaning up... 07:56:32 INFO - Return code: 0 07:56:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:56:32 INFO - Using env: {'DISPLAY': ':0', 07:56:32 INFO - 'HOME': '/home/cltbld', 07:56:32 INFO - 'LANG': 'en_US.UTF-8', 07:56:32 INFO - 'LANGUAGE': 'en_US:en', 07:56:32 INFO - 'LOGNAME': 'cltbld', 07:56:32 INFO - 'MAIL': '/var/mail/cltbld', 07:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:32 INFO - 'MOZ_NO_REMOTE': '1', 07:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:32 INFO - 'NO_EM_RESTART': '1', 07:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:32 INFO - 'PWD': '/builds/slave/test', 07:56:32 INFO - 'SHELL': '/bin/bash', 07:56:32 INFO - 'SHLVL': '1', 07:56:32 INFO - 'TERM': 'linux', 07:56:32 INFO - 'TMOUT': '86400', 07:56:32 INFO - 'USER': 'cltbld', 07:56:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:32 INFO - '_': '/tools/buildbot/bin/python'} 07:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:56:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:35 INFO - Downloading docopt-0.6.1.tar.gz 07:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:35 INFO - Running setup.py install for blobuploader 07:56:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:56:35 INFO - Running setup.py install for requests 07:56:35 INFO - Running setup.py install for docopt 07:56:35 INFO - Successfully installed blobuploader requests docopt 07:56:35 INFO - Cleaning up... 07:56:35 INFO - Return code: 0 07:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:56:35 INFO - Using env: {'DISPLAY': ':0', 07:56:35 INFO - 'HOME': '/home/cltbld', 07:56:35 INFO - 'LANG': 'en_US.UTF-8', 07:56:35 INFO - 'LANGUAGE': 'en_US:en', 07:56:35 INFO - 'LOGNAME': 'cltbld', 07:56:35 INFO - 'MAIL': '/var/mail/cltbld', 07:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:35 INFO - 'MOZ_NO_REMOTE': '1', 07:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:35 INFO - 'NO_EM_RESTART': '1', 07:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:35 INFO - 'PWD': '/builds/slave/test', 07:56:35 INFO - 'SHELL': '/bin/bash', 07:56:35 INFO - 'SHLVL': '1', 07:56:35 INFO - 'TERM': 'linux', 07:56:35 INFO - 'TMOUT': '86400', 07:56:35 INFO - 'USER': 'cltbld', 07:56:35 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:35 INFO - '_': '/tools/buildbot/bin/python'} 07:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:35 INFO - Running setup.py (path:/tmp/pip-eo810c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:36 INFO - Running setup.py (path:/tmp/pip-EdWQKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:36 INFO - Running setup.py (path:/tmp/pip-3YyHWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:36 INFO - Running setup.py (path:/tmp/pip-xf0OLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:36 INFO - Running setup.py (path:/tmp/pip-AVr8WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:36 INFO - Running setup.py (path:/tmp/pip-C26grK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:36 INFO - Running setup.py (path:/tmp/pip-aFwYvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:36 INFO - Running setup.py (path:/tmp/pip-XNOUoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:36 INFO - Running setup.py (path:/tmp/pip-uNOJ9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:36 INFO - Running setup.py (path:/tmp/pip-hOrVG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:36 INFO - Running setup.py (path:/tmp/pip-rvmyGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:36 INFO - Running setup.py (path:/tmp/pip-4EXfdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:36 INFO - Running setup.py (path:/tmp/pip-0EgPJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:36 INFO - Running setup.py (path:/tmp/pip-TSsEJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:36 INFO - Running setup.py (path:/tmp/pip-lin4Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:37 INFO - Running setup.py (path:/tmp/pip-XevLl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:37 INFO - Running setup.py (path:/tmp/pip-nCnn2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:37 INFO - Running setup.py install for manifestparser 07:56:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Running setup.py install for mozcrash 07:56:37 INFO - Running setup.py install for mozdebug 07:56:37 INFO - Running setup.py install for mozdevice 07:56:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Running setup.py install for mozfile 07:56:37 INFO - Running setup.py install for mozhttpd 07:56:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Running setup.py install for mozinfo 07:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Running setup.py install for mozInstall 07:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:56:37 INFO - Running setup.py install for mozleak 07:56:38 INFO - Running setup.py install for mozlog 07:56:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Running setup.py install for moznetwork 07:56:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Running setup.py install for mozprocess 07:56:38 INFO - Running setup.py install for mozprofile 07:56:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Running setup.py install for mozrunner 07:56:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Running setup.py install for mozscreenshot 07:56:38 INFO - Running setup.py install for moztest 07:56:38 INFO - Running setup.py install for mozversion 07:56:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:56:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:38 INFO - Cleaning up... 07:56:38 INFO - Return code: 0 07:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:56:38 INFO - Using env: {'DISPLAY': ':0', 07:56:38 INFO - 'HOME': '/home/cltbld', 07:56:38 INFO - 'LANG': 'en_US.UTF-8', 07:56:38 INFO - 'LANGUAGE': 'en_US:en', 07:56:38 INFO - 'LOGNAME': 'cltbld', 07:56:38 INFO - 'MAIL': '/var/mail/cltbld', 07:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:38 INFO - 'MOZ_NO_REMOTE': '1', 07:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:38 INFO - 'NO_EM_RESTART': '1', 07:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:38 INFO - 'PWD': '/builds/slave/test', 07:56:38 INFO - 'SHELL': '/bin/bash', 07:56:38 INFO - 'SHLVL': '1', 07:56:38 INFO - 'TERM': 'linux', 07:56:38 INFO - 'TMOUT': '86400', 07:56:38 INFO - 'USER': 'cltbld', 07:56:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:38 INFO - '_': '/tools/buildbot/bin/python'} 07:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:39 INFO - Running setup.py (path:/tmp/pip-rc7CYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:39 INFO - Running setup.py (path:/tmp/pip-KaYSDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:39 INFO - Running setup.py (path:/tmp/pip-9ASxrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:39 INFO - Running setup.py (path:/tmp/pip-XHRxAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:39 INFO - Running setup.py (path:/tmp/pip-8nwq2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:39 INFO - Running setup.py (path:/tmp/pip-Q6MPTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:39 INFO - Running setup.py (path:/tmp/pip-yubkkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:39 INFO - Running setup.py (path:/tmp/pip-xA6ZRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:39 INFO - Running setup.py (path:/tmp/pip-6A3IBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:39 INFO - Running setup.py (path:/tmp/pip-D6H5nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:39 INFO - Running setup.py (path:/tmp/pip-X2dTD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:39 INFO - Running setup.py (path:/tmp/pip-b4_XcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:40 INFO - Running setup.py (path:/tmp/pip-MQ4A9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:40 INFO - Running setup.py (path:/tmp/pip-1rzQ6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:40 INFO - Running setup.py (path:/tmp/pip-1mmnzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:40 INFO - Running setup.py (path:/tmp/pip-5IhKGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:40 INFO - Running setup.py (path:/tmp/pip-for4zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:56:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:42 INFO - Downloading blessings-1.6.tar.gz 07:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:42 INFO - Installing collected packages: blessings 07:56:42 INFO - Running setup.py install for blessings 07:56:42 INFO - Successfully installed blessings 07:56:42 INFO - Cleaning up... 07:56:42 INFO - Return code: 0 07:56:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:42 INFO - Reading from file tmpfile_stdout 07:56:42 INFO - Current package versions: 07:56:42 INFO - argparse == 1.2.1 07:56:42 INFO - blessings == 1.6 07:56:42 INFO - blobuploader == 1.2.4 07:56:42 INFO - docopt == 0.6.1 07:56:42 INFO - functools32 == 3.2.3-2 07:56:42 INFO - jsonschema == 2.5.1 07:56:42 INFO - manifestparser == 1.1 07:56:42 INFO - mozInstall == 1.12 07:56:42 INFO - mozcrash == 0.17 07:56:42 INFO - mozdebug == 0.1 07:56:42 INFO - mozdevice == 0.48 07:56:42 INFO - mozfile == 1.2 07:56:42 INFO - mozhttpd == 0.7 07:56:42 INFO - mozinfo == 0.9 07:56:42 INFO - mozleak == 0.1 07:56:42 INFO - mozlog == 3.2 07:56:42 INFO - moznetwork == 0.27 07:56:42 INFO - mozprocess == 0.22 07:56:42 INFO - mozprofile == 0.28 07:56:42 INFO - mozrunner == 6.11 07:56:42 INFO - mozscreenshot == 0.1 07:56:42 INFO - mozsystemmonitor == 0.3 07:56:42 INFO - moztest == 0.7 07:56:42 INFO - mozversion == 1.4 07:56:42 INFO - psutil == 3.1.1 07:56:42 INFO - requests == 1.2.3 07:56:42 INFO - wsgiref == 0.1.2 07:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:56:42 INFO - Using env: {'DISPLAY': ':0', 07:56:42 INFO - 'HOME': '/home/cltbld', 07:56:42 INFO - 'LANG': 'en_US.UTF-8', 07:56:42 INFO - 'LANGUAGE': 'en_US:en', 07:56:42 INFO - 'LOGNAME': 'cltbld', 07:56:42 INFO - 'MAIL': '/var/mail/cltbld', 07:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:42 INFO - 'MOZ_NO_REMOTE': '1', 07:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:42 INFO - 'NO_EM_RESTART': '1', 07:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:42 INFO - 'PWD': '/builds/slave/test', 07:56:42 INFO - 'SHELL': '/bin/bash', 07:56:42 INFO - 'SHLVL': '1', 07:56:42 INFO - 'TERM': 'linux', 07:56:42 INFO - 'TMOUT': '86400', 07:56:42 INFO - 'USER': 'cltbld', 07:56:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:42 INFO - '_': '/tools/buildbot/bin/python'} 07:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:56:42 INFO - Cleaning up... 07:56:42 INFO - Return code: 0 07:56:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:56:42 INFO - Using env: {'DISPLAY': ':0', 07:56:42 INFO - 'HOME': '/home/cltbld', 07:56:42 INFO - 'LANG': 'en_US.UTF-8', 07:56:42 INFO - 'LANGUAGE': 'en_US:en', 07:56:42 INFO - 'LOGNAME': 'cltbld', 07:56:42 INFO - 'MAIL': '/var/mail/cltbld', 07:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:42 INFO - 'MOZ_NO_REMOTE': '1', 07:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:42 INFO - 'NO_EM_RESTART': '1', 07:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:42 INFO - 'PWD': '/builds/slave/test', 07:56:42 INFO - 'SHELL': '/bin/bash', 07:56:42 INFO - 'SHLVL': '1', 07:56:42 INFO - 'TERM': 'linux', 07:56:42 INFO - 'TMOUT': '86400', 07:56:42 INFO - 'USER': 'cltbld', 07:56:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:42 INFO - '_': '/tools/buildbot/bin/python'} 07:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:56:43 INFO - Cleaning up... 07:56:43 INFO - Return code: 0 07:56:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1825da8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:56:43 INFO - Using env: {'DISPLAY': ':0', 07:56:43 INFO - 'HOME': '/home/cltbld', 07:56:43 INFO - 'LANG': 'en_US.UTF-8', 07:56:43 INFO - 'LANGUAGE': 'en_US:en', 07:56:43 INFO - 'LOGNAME': 'cltbld', 07:56:43 INFO - 'MAIL': '/var/mail/cltbld', 07:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:43 INFO - 'MOZ_NO_REMOTE': '1', 07:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:43 INFO - 'NO_EM_RESTART': '1', 07:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:43 INFO - 'PWD': '/builds/slave/test', 07:56:43 INFO - 'SHELL': '/bin/bash', 07:56:43 INFO - 'SHLVL': '1', 07:56:43 INFO - 'TERM': 'linux', 07:56:43 INFO - 'TMOUT': '86400', 07:56:43 INFO - 'USER': 'cltbld', 07:56:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:43 INFO - '_': '/tools/buildbot/bin/python'} 07:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:43 INFO - Downloading/unpacking flake8 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:46 INFO - no previously-included directories found matching 'docs/_build' 07:56:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:46 INFO - Running setup.py install for pep8 07:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:46 INFO - no previously-included directories found matching 'docs/_build' 07:56:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:56:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:46 INFO - Cleaning up... 07:56:46 INFO - Return code: 0 07:56:46 INFO - Running post-action listener: _resource_record_post_action 07:56:46 INFO - Running post-action listener: _start_resource_monitoring 07:56:46 INFO - Starting resource monitoring. 07:56:46 INFO - ##### 07:56:46 INFO - ##### Finished create-virtualenv step (success) 07:56:46 INFO - ##### 07:56:46 INFO - ##### 07:56:46 INFO - ##### Running install step. 07:56:46 INFO - ##### 07:56:46 INFO - Running pre-action listener: _resource_record_pre_action 07:56:46 INFO - Running main action method: install 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:46 INFO - Reading from file tmpfile_stdout 07:56:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:56:46 INFO - Reading from file tmpfile_stdout 07:56:46 INFO - Output received: 07:56:46 INFO - Usage: mozinstall [options] installer 07:56:46 INFO - Options: 07:56:46 INFO - -h, --help show this help message and exit 07:56:46 INFO - -d DEST, --destination=DEST 07:56:46 INFO - Directory to install application into. [default: 07:56:46 INFO - "/builds/slave/test"] 07:56:46 INFO - --app=APP Application being installed. [default: firefox] 07:56:46 INFO - mkdir: /builds/slave/test/build/application 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:57:02 INFO - Reading from file tmpfile_stdout 07:57:02 INFO - Output received: 07:57:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:57:02 INFO - Running post-action listener: _resource_record_post_action 07:57:02 INFO - ##### 07:57:02 INFO - ##### Finished install step (success) 07:57:02 INFO - ##### 07:57:02 INFO - ##### 07:57:02 INFO - ##### Running run-tests step. 07:57:02 INFO - ##### 07:57:02 INFO - Running pre-action listener: _resource_record_pre_action 07:57:02 INFO - Running main action method: run_tests 07:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:02 INFO - Python 2.7.3 07:57:02 INFO - Return code: 0 07:57:02 INFO - grabbing minidump binary from tooltool 07:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:57:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18451c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18460c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1846550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:57:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:57:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:57:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:02 INFO - Return code: 0 07:57:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:57:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:57:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:57:03 INFO - Return code: 0 07:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:57:03 INFO - Using env: {'DISPLAY': ':0', 07:57:03 INFO - 'HOME': '/home/cltbld', 07:57:03 INFO - 'LANG': 'en_US.UTF-8', 07:57:03 INFO - 'LANGUAGE': 'en_US:en', 07:57:03 INFO - 'LOGNAME': 'cltbld', 07:57:03 INFO - 'MAIL': '/var/mail/cltbld', 07:57:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:03 INFO - 'MOZ_NO_REMOTE': '1', 07:57:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:57:03 INFO - 'NO_EM_RESTART': '1', 07:57:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:03 INFO - 'PWD': '/builds/slave/test', 07:57:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:03 INFO - 'SHELL': '/bin/bash', 07:57:03 INFO - 'SHLVL': '1', 07:57:03 INFO - 'TERM': 'linux', 07:57:03 INFO - 'TMOUT': '86400', 07:57:03 INFO - 'USER': 'cltbld', 07:57:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724', 07:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:03 INFO - '_': '/tools/buildbot/bin/python'} 07:57:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:57:03 INFO - mozversion application_buildid: 20160609063930 07:57:03 INFO - mozversion application_changeset: f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 07:57:03 INFO - mozversion application_display_name: Nightly 07:57:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:03 INFO - mozversion application_name: Firefox 07:57:03 INFO - mozversion application_remotingname: firefox 07:57:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:57:03 INFO - mozversion application_vendor: Mozilla 07:57:03 INFO - mozversion application_version: 50.0a1 07:57:03 INFO - mozversion platform_buildid: 20160609063930 07:57:03 INFO - mozversion platform_changeset: f8e3b81a79f45ef8647c98281a9a00d1ddb28b73 07:57:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:57:03 INFO - mozversion platform_version: 50.0a1 07:57:03 INFO - using testdate: 1465484223 07:57:03 INFO - actual date: 1465484223 07:57:03 INFO - starting webserver on 'localhost:34344' 07:57:03 INFO - SUITE-START | Running 2 tests 07:57:03 INFO - TEST-START | dromaeo_css 07:57:03 INFO - operating with platform_type : linux_ 07:57:03 INFO - Initialising browser for dromaeo_css test... 07:57:03 INFO - TEST-INFO | started process 14402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJFl6Xx/profile http://localhost:34344/getInfo.html) 07:57:08 INFO - PROCESS | 14402 | __metrics Screen width/height:1600/1200 07:57:08 INFO - PROCESS | 14402 | colorDepth:24 07:57:08 INFO - PROCESS | 14402 | Browser inner width/height: 1024/697 07:57:08 INFO - PROCESS | 14402 | __metrics 07:57:09 ERROR - PROCESS | 14402 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:57:09 INFO - PROCESS | 14402 | console.error: PushService: 07:57:09 INFO - PROCESS | 14402 | stateChangeProcessEnqueue: Error transitioning state 07:57:09 INFO - PROCESS | 14402 | UnknownError 07:57:10 INFO - TEST-INFO | 14402: exit 0 07:57:10 INFO - Browser initialized. 07:57:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:10 INFO - TEST-INFO | started process 14480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJFl6Xx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:22 INFO - PROCESS | 14480 | RSS: Main: 175476736 07:57:22 INFO - PROCESS | 14480 | 07:58:14 INFO - PROCESS | 14480 | 1465484294321 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:00:26 INFO - PROCESS | 14480 | Cycle 1(1): loaded http://localhost:34344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34344/tests/dromaeo/cssquery-ext.html) 08:00:27 INFO - PROCESS | 14480 | RSS: Main: 287297536 08:00:27 INFO - PROCESS | 14480 | 08:03:30 INFO - PROCESS | 14480 | Cycle 1(1): loaded http://localhost:34344/tests/dromaeo/cssquery-ext.html (next: http://localhost:34344/tests/dromaeo/cssquery-jquery.html) 08:03:30 INFO - PROCESS | 14480 | RSS: Main: 258674688 08:03:30 INFO - PROCESS | 14480 | 08:06:32 INFO - PROCESS | 14480 | Cycle 1(1): loaded http://localhost:34344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34344/tests/dromaeo/cssquery-mootools.html) 08:06:33 INFO - PROCESS | 14480 | RSS: Main: 267476992 08:06:33 INFO - PROCESS | 14480 | 08:09:35 INFO - PROCESS | 14480 | Cycle 1(1): loaded http://localhost:34344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34344/tests/dromaeo/cssquery-prototype.html) 08:09:36 INFO - PROCESS | 14480 | RSS: Main: 262922240 08:09:36 INFO - PROCESS | 14480 | 08:12:39 INFO - PROCESS | 14480 | Cycle 1(1): loaded http://localhost:34344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34344/tests/dromaeo/cssquery-yui.html) 08:12:40 INFO - PROCESS | 14480 | RSS: Main: 249122816 08:12:40 INFO - PROCESS | 14480 | 08:15:42 INFO - PROCESS | 14480 | Cycle 1(1): loaded http://localhost:34344/tests/dromaeo/cssquery-yui.html (next: http://localhost:34344/tests/dromaeo/cssquery-dojo.html) 08:15:43 INFO - PROCESS | 14480 | RSS: Main: 289599488 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | __start_tp_report 08:15:43 INFO - PROCESS | 14480 | _x_x_mozilla_page_load 08:15:43 INFO - PROCESS | 14480 | _x_x_mozilla_page_load_details 08:15:43 INFO - PROCESS | 14480 | |i|pagename|runs| 08:15:43 INFO - PROCESS | 14480 | |0;dojo.html;2604.231751633268;2627.382565097203;2645.7751091157243;2658.8936442542285;2667.199840047985;4632.559906808856;4686.929696054562;4730.834420795269;4783.856484305472;4854.854354369366;4715.811367545294;4735.171345014626;4741.620670346372;4797.136515427222;4805.038992201565;4362.738235705852;4394.3188805735;4398.802053907574;4416.447944006999;4419.0499042705815;4361.171377438277;4467.374567560544;4490.775461226942;4497.145542346943;4532.682712210147;4434.224010798098;4477.708948918326;4492.887677808081;4496.168208881368;4519.615832654228;4290.227759003378;4318.956810431887;4330.523642399334;4338.414314067592;4356.172327257811;4288.099499105192;4308.569143085698;4357.36818161368;4365.301551751736;4397.1865204937185;4772.570468657837;4777.761111944389;4806.447258565275;4834.3473631059705;4836.371271734652;4959.528844759742;5012.649114561982;5038.420581633122;5069.315642388267;5095.949040509585;5110.97444512775;5160.432352441228;5163.845084647466;5172.405173405069;5181.53366197044;4598.0803839232285;4769.165396055676;4797.40032495938;4813.302071199656;4817.566419022235;5155.7679904404395;5193.195054766517;5203.791848326025;5215.55667768244;5270.8155214567305;5022.924656130161;5028.296038554606;5032.622553308516;5048.116579598555;5048.444671086178;4944.826931057396;4994.450610432849;5053.191489361758;5053.292539044537;5077.136886729265;4950.801967921315;4971.229459433794;4989.90020199594;4992.475790042066;5041.168207245837;4954.826581069718;4965.950340496549;4965.950340496621;4968.22992436173;5018.397792264952;4185.769782661982;4233.661307095425;4267.554328597657;4267.701260911706;4308.246056940023;3753.0242137044565;3759.6804271637216;3767;3795.69634429245;3848.3842585186235;4350.564943505624;4363.127374525107;4364.323529852878;4405.867823965286;4408.625266852354;5013.097642424325;5018.548330650186;5068.4424713281505;5134.460881607378;5180.456052114474;4316.352547117895;4342.41377414045;4345.239583072949;4385.342198670161;4388.166248412791;4582.495925448198;4587.541245875453;4591.288350305708;4592.15045216636;4635.397398338262;4669.229577119737;4744.857654270378;4780.569748722632;4796.112719146969;4802.135615589227;5082.186850103965;5098.796048158032;5100.897982040264;5104.183330667075;5141.203113517411;4743.549362810528;4779.30700048498;4787.257975013878;4789.3055506952;4827.396575428072;4953.2074868020945;4970.3290055842;5006.849794506171;5045.091883460866;5060.84817455477;5114.156164233009;5124.077666020152;5137.1010073237785;5137.44481552073;5144.074066668036;4970.453250142409;4983.352164218629;4985.177445721561;4986.252062190701;5022.974885125551;4863.027394521039;4897.0450762101045;4929.06347793918;4976.776045078052;4986.650934434555;4873.171560834596;4904.239842824368;4913.484084171254;4934.901301973869;4961.776720047678;4854.150523658416;5009.699418034929;5010.198368261061;5046.747662616928;5060.063888180698;4717.764111794465;4757.952420475751;4861.878453038702;4885.169521181337;4885.2427873679635 08:15:43 INFO - PROCESS | 14480 | |1;ext.html;562.9838142153412;580.5761793890459;580.9506191973682;584.7368684092158;591.9556033297501;27178;39457.210855782905;41138;41255.17489650205;44573.33140002895;41645.791771041106;42094.57905420945;42108.57891421085;42111.57888421115;42158.57841421585;7539.434542409341;7687.0391201099865;7831.334336581397;7840.960795196016;7841.294283514482;7501.849963000764;7711.768646940601;7715.498492597963;9936.254780891426;10119.291649584533;10053.849192262085;10110.393376397404;10116.19070474364;10120.493975301242;10123.341982771097;9997.750056248578;10025.298229123964;10048.346857454315;10051.89948100517;10062.295639305288;7461.403087753021;9683.467409292487;10014.298999070068;10017.599296028151;10341.121004714609;38693;39388.60611393878;39459.60540394588;39459.8027009866;39497;2763.1296141715297;2792.8184667996516;2890.713632433568;3130.9217269568217;3248.431524483206;29897.551536726965;30539.847300763577;30585.235369115726;30670.233244168852;31105.222369440944;3326.248829570611;3461.8615255389755;3469;3530.082178633548;3597.0467826026124;261299;262993.68503157556;263573;264090;264538;50472.242916356285;50747.49252507502;50992.74503627458;51080;51081.48918510842;33341.83329083339;34135.829320853234;34148;35864.64135358665;59372;15374.692506149815;15452.5364239073;15493.302801373966;15493.535193944199;15514.301856416489;10792.352458852494;12156.331401772988;12251.203671761306;12256.264624122581;12270.509179632714;18016.189271482814;18541.16564754589;18553.165107570192;19354.612907741765;19398.515037123903;6742.797716068526;6872.450203983669;6883.931160688329;6910.896336554955;7173.820654483576;776.2237762237762;862.7886167888907;894.3113802372137;911.0206527982313;951.1629765806184;27725.58411623827;28316.43367132687;28752.281192969924;29074.70925290762;29104.85447572791;962.6775030364767;984.8621193032981;1025.1849779425374;1027.440045175381;1054.0092313225543;15275.847241527443;15350.692986140215;15423.460178893909;15580;15587.454439094578;385397;389152;389212;389422;391673;51443.228351574755;51886.22170667443;51910;51941;51982;1012.6202673997251;1123.2025262064026;1175.1127898436625;1178.7406770510474;1187.186777057701;26797.464050718485;29352.412951741273;29577.26056848596;30108.849455753458;30365.69634303717;44068.55931440645;44485.55329456911;44510.3323450155;44580.33129503125;44604;300804;301742;302174;302644;302973;20187.697184542536;25288.36779080464;25772.09797657073;26220.475590488466;26316.868415658566;42938.35592466178;43294.56705433031;43350.78324608357;44104.77947610241;44403.33394999142;35111;35346;36374.90875273746;36423.81788091043;36455.27089458143;36344.27311453809;36640.81679591585;36760.81619591885;36871.63128368682;37231;36267;37115;37126.07184820401;37212.627873722;37362.25275494529;31534;33290.5006424899;33682.494762579074;34085.82957085199;34193.82903085568;25273.87363063173;25692.357691057125;25912.352191195372;25915.740842591335;26059.21822345333 08:15:43 INFO - PROCESS | 14480 | |2;jquery.html;352.73721077797046;353.288124429275;356.54718507495477;368.71793078295093;377.464001118412;15824;16403.835961640394;16979.91510042448;17016;17034.488965331046;16071.839281607181;16639.33442662292;16894.239759210835;17200;17208.13959302036;4924.827631032915;5148.845534633948;5167.276581278624;5172.741362931857;5184.844454666347;3064.34116664917;3200.1679563313473;5021.1213037718435;5566.415526369713;5882.941170588282;5832.1834943108;5863.208466856983;5914.349421563625;5923.08192230205;5931.110333449996;5683.3464151622475;5770.855728606797;5839.883202335972;5854.76580936762;5860.443257890493;2604.231751633273;2742.3829638331417;2744.2316151477617;5089.898202035975;5111.131107711698;14717.411303547846;20047.49881252966;20047.699284510745;21183.788162118337;21383;1977.812107849752;2176.836737244713;2366.2073205476186;2378.54807586558;2383.41606306456;12580.370981450891;12840.293783841886;12954.417051232716;13056.738865222642;13504;1534.2022148482727;1545.8299587045417;1565.7865154505237;1573.6695293988275;1670.3485640600175;42596.57403425988;42921.785391072845;48793;65846.34153658402;66260;9041.728748137566;9104.31717621181;9630.903690963141;9648.324617276723;9864.852027219598;12562.120651554485;12628.81056784149;12654.81017784734;12669.113162078565;12677.936610316889;7438.516496427715;7489.475736698488;7501.474896757284;7676.11724651661;7742.187070357644;7482.85034299311;7540.773776786705;7543.170251272356;7623.047119110111;7687.5387476751575;6000.129981152709;6034.762873610987;6056.182415373956;6100.633961962297;6176.66028368444;1511.8185817701726;1622.245655770049;1626.8942518736244;1671.4484220207303;1719.9312027518758;360.7727131906934;786.1509569664748;834.6077343648476;843.8944982073381;851.82537579796;10182.134518566005;10715.624953126604;10851.294665846695;11072.944635276772;11163.051140652973;381.54214942069626;383.25648242409636;387.19656712322046;388.52987884659876;405.8701215610976;5865.794697185578;5888.705564721747;5915.467607915309;5941.168236446901;6007.879842403127;293561;297057;410623;411977;418569;81633.59183204046;83743;85451.57274213589;86845;87972.5601371989;941.8304705153001;957.2676902169845;960.2462067277154;960.6877764726491;971.601643326247;15638.592526672654;15876.444324448588;15903.761443578123;16410;16656.666866662355;35211.64788352186;36003.27993440064;36071.81964090268;37833.62166378411;38199.61800382072;51691;53430.4656953441;53828.730856345464;54186.72906635442;54846.451535484135;7545.132309784225;7648.541087534543;7712.730054448068;7715.807104822425;7953.5227886327;11107.500162492868;11163.218574699693;11333.150013749168;11790.705232369259;12088.335141566946;6502.837429064311;8701.216890479887;9803;10094.293399461967;10287.588496460357;10161.237907157141;10400.895991039994;10523.631672891412;10773.299735517166;10805.135589153006;9978.401295922267;10199.7450063749;10238.385696858213;10395.428251445941;10427.478626068514;7580.166181720117;7736.5687347838575;7771.106322772954;7785.961070194613;8030.759077227693;9681.467519286507;10039.799204015733;10097.848532271875;10169.084782369622;10254.58981640726 08:15:43 INFO - PROCESS | 14480 | |3;mootools.html;1266.512392728799;1368.3773882883286;1404.606710121166;1471.5364660132057;1674.891132076415;6494.123293355401;7409.8518029639445;7635.198304178065;7658.54048757075;7826.5695386753705;7593.810154746134;7721.652525636346;7725.304722574967;7737.032870891138;7772.261635144667;1804.124999375302;1871.6631006418838;1873.812618738129;2169.154029928325;2201.3506015725397;1846.7322238275442;2113.92601258956;2216.2686313516583;2217.855839370444;2219.178903805594;2144.378130342199;2157.0508976050564;2182.847200695952;2185.4645611825044;2196.6595177747477;1800.9459716208535;2168.5554461335387;2190.0582749417745;2192.3203806819856;2193.967090493644;2094.916203351864;2173.500094978164;2173.945651358713;2182.301663467691;2183.5960347335795;7523.0972283326355;7554.395648348119;7566.886496702554;7573.886391704129;7615.5811430371305;4268.509121451042;4395.362672412514;4414.735115893057;4420.248557745191;4428.848499390149;2586.6766654168227;2659.6675415573054;2789.497890379731;2805.579163125527;2811.1847564206355;856.2336708645727;866.540733411293;877.2893955895681;883.9911600884037;886.0607755778894;10025.799484010351;10313.48432578368;10345.327553708985;10356.637517686844;10366.170706343475;4044.9078748737675;4048.9190216196102;4153.7300075494995;4156.044109854751;4166.250074986471;8760.605772740242;8780.912190878009;8786.384953053353;8792.164744349277;8793.988691300454;4545.772711364419;4549.181147393435;4550.067236216568;4556;4558.749268790249;3434.5363375944426;3470.9305813884084;4116.341385378385;4221.936670949938;4227.133437645275;3517.120719820045;3563.1804684922095;3662.08447888028;3669.1927775889794;3680.208755117609;1122.9113848242264;1150.2753265442718;1157.5890558851654;1171.6016554371554;1177.5054477119631;649.5128653509868;786.9685212591547;787.6022608582629;792.3186059988406;798.4211446701095;4793.49668284832;4964.255361695702;5029.84910452687;5036.194208926554;5235.769594145373;358.18870258863694;371.6209466344314;374.04431677064815;375.03615707631127;377.4941578285111;3177.132612917674;3441.3633477806184;3446.5691788526433;3455.913602159966;3462.1690794209712;9096.454212747256;9480;9492.098250666175;9543.713688589354;9552.474613896164;9431.62273509052;9444.291678124031;9448.90551094494;9476.147146756686;9478.241740660731;7023.403010744144;7233.312835280745;7283.4537409694485;7308.5249458786075;7311.707531698672;4930.403658778996;5101.036101101028;5103.2975764798475;5153.742312884266;5257.4216836147225;8865;8909.866352004854;8961.507117108622;8968.955155224183;8978.191962723386;8380.287675547646;8782.29741620656;8815.471071735716;8927.553622318988;8943.37396382247;5540.722963851872;6365.490760739222;6387.9459889119635;6471.708773105316;6553.672316384066;7252.89120663201;7289.16174639902;7336.669849856663;7360.4479664026485;7409.110906691231;6497;6650.866982660416;6705.4635629150525;6739.865202695821;6875.174979002351;6425.967870160619;6451.3548645135115;6473.741050358121;6480.70836812354;6527.184101987252;5749.425057494217;5803.332616749128;5842.474177324061;5896.8820623586425;5904.114382842608;4045.1100757834406;4114;4211.978940105279;4218.873433796991;4242.681798865159;4229.435393328535;4295.570442955679;4338.067315527177;4397.472303323621;4398.868033958986 08:15:43 INFO - PROCESS | 14480 | |4;prototype.html;290.5423957267304;291.5844920987592;299.71676765456647;301.49951081205205;304.34413838178705;4816.397950256218;4823.83116590919;4844.757762111898;4884.804607815688;4891.388576427947;4753.524647535253;4848.030393921221;4857.9757101214445;4862.465128835825;4868.683535570194;3572.3926932421423;3660.926781464369;3789.905252368685;3792.5448946126503;3810.4474851146565;3786.9810650946706;3793.070697679059;3803.619638036202;3814.370628846237;3820.36963900956;3724.5344331958504;3758.9812050939845;3777.9032636886654;3779.6976241900584;3779.79211143387;3543.2204914918675;3660.2862441823854;3762.1159027628487;3772.8113594320175;3775.9056023599355;3314.5028245763087;3317.800931944067;3317.834108294576;3322.3853587086223;3323.933521329584;4698.553637404441;4702.835400760991;4713.6936099153445;4714.986277950257;4767.022760334124;4162.313218318974;4298.935515967263;4304.634106100985;4314.892127696801;4345.391645169679;5005.724685142316;5030.446650868402;5037.143685573461;5041.19340905457;5044.6973181608855;3607.1703508193;3609.855605775792;3615.7468977171607;3617.7105831533677;3641.8361173747244;5057.645964782467;5237.450067742909;5250.159974404077;5254.21186821976;5256.159014557652;3691.3540130477595;3724.5902950675404;3728.5712143103347;3736.001239336996;3740.5698344690163;3753.042974041602;3754.4931434256573;3756.3938618926136;3811.1805961718364;3814.408766641175;4274.764887931132;4294.141171765659;4312.978435107804;4320.567943205717;4328.458942632171;4876.707397556158;5034.79860805571;5038.722870242172;5058.570021548209;5059.9121188944555;1299.5451591942744;1299.6815780133738;1302.3423171298434;1307.3920626908532;1311.4098655605017;810.4084018666407;824.2293455619016;844.2317491083207;850.7235148576738;851.3146916731966;4339.5660433956355;4460.301517581816;4468;4479.664025198123;4488.58609538001;5191.714455704972;5256.710880901587;5265.368155821326;5271.341082364705;5279.340082489689;4396.362527433568;4421.40311058003;4469.575390337913;4516.480604730498;4523.773811309421;2646.5897785843226;2800.019993002433;2810.775137988956;2817.690054094048;2833.8724757385553;4964.230544265644;4965.875853103701;4971.304017437562;4981.302617633534;4987.1771157759285;5287.365516138088;5355.732213389315;5416.8104116355735;5438.320209973754;5442.292501974718;4953.50464953509;4955.306257124005;4969.627277954096;4990.351254336913;4994.850154495371;5265.736713164403;5279.128943724396;5314.867128321823;5323.281357016908;5342.652727572696;5040.470750571138;5195.402528709247;5202.843914682566;5215.530602245816;5216.504432078947;4911.557959783494;4930.359053323188;4949.020391843292;4993.850184494471;5005.874853128701;3386.627470978141;3426.794392336468;3436.7937923724658;3437.2781715839956;3438.621751607371;4551.864232957512;4751.358566593465;4818.10864989978;4841.9031619366715;4848.684835485682;4558.72063968016;4571.954280457153;4589.426321709786;4604.470485894165;4605.516420775771;4593.6095431887325;4598.88502787433;4604.3323718061365;4622.375979242759;4625.028743963805;4421.965895688019;4529.252673308867;4574.908501830011;4617.884552886205;4622.260438329851;4678.883027924193;4919.188333925005;5038.2190760432195;5048.697078175174;5050.191969284897;4922.803087876445;4954.727489988085;4967.552920237196;4994.550490455877;4999.250112483157 08:15:43 INFO - PROCESS | 14480 | |5;yui.html;522.4435975685894;546.3034630845674;578.1270281874368;584.1675612252541;611.7155522681952;10381.740456488591;10943.616973405913;11341.829872551907;11353.943230283838;11379;11414.7146321342;11725.120615953794;11781.29312241266;11802.114841386887;11872.584459543918;620.1194304088183;747.6486051555787;762.973295934641;775.9922400776005;777.7899967008905;771.5447885747408;772.3782355204058;773.1456740301969;775.3177204060419;775.4726785785664;814.1166833985104;814.7840822182127;815.5473712089788;816.5753808019826;817.2236375443323;638.2181827261613;787.8424315136996;806.4314658165979;806.8426656801926;808.0949336742827;594.9583529152961;595.1043679262725;595.330253464852;595.5295316699802;595.5354823237882;10770.892291077067;10861.40262285574;10886.129109671207;10923.289986150874;10924.945375273152;11107.333559986426;11464.598739044177;11837.230580012272;11853.288802671867;12274.509019639203;10756.731081723019;10854.945725271402;11066.612668556561;11108;11236.438178091063;3564.0733409313507;3566.589842168132;3599;3611.5485564304463;3626.8367923443507;56321.71839140819;57490.42509574934;57968;57995.42004579942;58604;9164.312676549285;9399.812003760024;9443.055694430503;9787.608495660237;9806.852897206547;16579.336826527044;16581.336746530003;16585.83414165867;16642.83357166437;16747.1626418681;6186.412290832363;6257.217847769029;6320.178376810985;6484.059811327331;6572.309907459744;3505.1412403961194;3526.4005119129297;3541.1855273287288;3555.6444355564754;3603.5046554005353;2494.3390001649577;2582.1607977407416;2587.107447930461;2592.468543948524;3049.35963447674;515.7833709841875;519.2470917170118;521.3863093724915;531.9361676598833;532.4994505165132;428.8520460441143;430.2202529892887;459.7586267209742;460.2650968927138;497.2963256991389;7218.386437152901;7225.494215404871;7432.814179645444;7556.546607203585;7752.147263800977;433.9127110608001;487.5514526635504;511.53961434708316;531.9148936170222;542.4494138449477;3361.2269178088686;3429.53701250333;3441.5353927219503;3484.3902317094407;3512.473129030615;54604.45395545994;55122.72438637861;56291.43708562944;56294.71852640792;56313.43686563164;52129.739351303004;63706.6814665933;72552.63723681348;74123.25876741164;84516;75209;78253.2174678246;78405.60797195978;79250.99999999885;79455.20544794478;6634.635095069818;6679.599224046573;6876.931230687629;6878.518503704692;6891.896621550781;31293.061208163792;41328.79335603303;47539.967406192714;48027.5197248023;48058.75970620124;58664.120038198605;58799;66311.33688663051;66495;66738.33261667321;8866.822663546563;9030.90969090327;9039.774005649648;9083.500407477652;9242.491662958602;9501.04989501072;9703.6118555257;9816.85274720894;9863.556139973862;10378.896211037792;8960;8983.326250531367;9043.366964312436;9184.265258779415;9488.85766713486;8787.253083487974;8818.162274583905;8922;8955.686550970684;9300.348975571645;8792.384533082623;8929.866052009094;8949.865752013595;8994.595243214202;9440.33917625787;7557.924420755942;7695;7786.357143570745;7914;7961.840763184588;7815.062192536932;7838.372930165687;8003.31971782405;8485.448445851;8505.489670619783 08:15:43 INFO - PROCESS | 14480 | __end_tp_report 08:15:43 INFO - PROCESS | 14480 | __start_cc_report 08:15:43 INFO - PROCESS | 14480 | _x_x_mozilla_cycle_collect,1048 08:15:43 INFO - PROCESS | 14480 | __end_cc_report 08:15:43 INFO - PROCESS | 14480 | __startTimestamp1465485343076__endTimestamp 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | ------- Summary: start ------- 08:15:43 INFO - PROCESS | 14480 | Number of tests: 6 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | [#0] dojo.html Cycles:165 Average:4698.34 Median:4817.57 stddev:490.51 (10.2%) stddev-sans-first:463.69 08:15:43 INFO - PROCESS | 14480 | Values: 2604.2 2627.4 2645.8 2658.9 2667.2 4632.6 4686.9 4730.8 4783.9 4854.9 4715.8 4735.2 4741.6 4797.1 4805.0 4362.7 4394.3 4398.8 4416.4 4419.0 4361.2 4467.4 4490.8 4497.1 4532.7 4434.2 4477.7 4492.9 4496.2 4519.6 4290.2 4319.0 4330.5 4338.4 4356.2 4288.1 4308.6 4357.4 4365.3 4397.2 4772.6 4777.8 4806.4 4834.3 4836.4 4959.5 5012.6 5038.4 5069.3 5095.9 5111.0 5160.4 5163.8 5172.4 5181.5 4598.1 4769.2 4797.4 4813.3 4817.6 5155.8 5193.2 5203.8 5215.6 5270.8 5022.9 5028.3 5032.6 5048.1 5048.4 4944.8 4994.5 5053.2 5053.3 5077.1 4950.8 4971.2 4989.9 4992.5 5041.2 4954.8 4966.0 4966.0 4968.2 5018.4 4185.8 4233.7 4267.6 4267.7 4308.2 3753.0 3759.7 3767.0 3795.7 3848.4 4350.6 4363.1 4364.3 4405.9 4408.6 5013.1 5018.5 5068.4 5134.5 5180.5 4316.4 4342.4 4345.2 4385.3 4388.2 4582.5 4587.5 4591.3 4592.2 4635.4 4669.2 4744.9 4780.6 4796.1 4802.1 5082.2 5098.8 5100.9 5104.2 5141.2 4743.5 4779.3 4787.3 4789.3 4827.4 4953.2 4970.3 5006.8 5045.1 5060.8 5114.2 5124.1 5137.1 5137.4 5144.1 4970.5 4983.4 4985.2 4986.3 5023.0 4863.0 4897.0 4929.1 4976.8 4986.7 4873.2 4904.2 4913.5 4934.9 4961.8 4854.2 5009.7 5010.2 5046.7 5060.1 4717.8 4758.0 4861.9 4885.2 4885.2 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | [#1] ext.html Cycles:180 Average:47531.10 Median:18827.85 stddev:84676.36 (449.7%) stddev-sans-first:84840.46 08:15:43 INFO - PROCESS | 14480 | Values: 563.0 580.6 581.0 584.7 592.0 27178.0 39457.2 41138.0 41255.2 44573.3 41645.8 42094.6 42108.6 42111.6 42158.6 7539.4 7687.0 7831.3 7841.0 7841.3 7501.8 7711.8 7715.5 9936.3 10119.3 10053.8 10110.4 10116.2 10120.5 10123.3 9997.8 10025.3 10048.3 10051.9 10062.3 7461.4 9683.5 10014.3 10017.6 10341.1 38693.0 39388.6 39459.6 39459.8 39497.0 2763.1 2792.8 2890.7 3130.9 3248.4 29897.6 30539.8 30585.2 30670.2 31105.2 3326.2 3461.9 3469.0 3530.1 3597.0 261299.0 262993.7 263573.0 264090.0 264538.0 50472.2 50747.5 50992.7 51080.0 51081.5 33341.8 34135.8 34148.0 35864.6 59372.0 15374.7 15452.5 15493.3 15493.5 15514.3 10792.4 12156.3 12251.2 12256.3 12270.5 18016.2 18541.2 18553.2 19354.6 19398.5 6742.8 6872.5 6883.9 6910.9 7173.8 776.2 862.8 894.3 911.0 951.2 27725.6 28316.4 28752.3 29074.7 29104.9 962.7 984.9 1025.2 1027.4 1054.0 15275.8 15350.7 15423.5 15580.0 15587.5 385397.0 389152.0 389212.0 389422.0 391673.0 51443.2 51886.2 51910.0 51941.0 51982.0 1012.6 1123.2 1175.1 1178.7 1187.2 26797.5 29352.4 29577.3 30108.8 30365.7 44068.6 44485.6 44510.3 44580.3 44604.0 300804.0 301742.0 302174.0 302644.0 302973.0 20187.7 25288.4 25772.1 26220.5 26316.9 42938.4 43294.6 43350.8 44104.8 44403.3 35111.0 35346.0 36374.9 36423.8 36455.3 36344.3 36640.8 36760.8 36871.6 37231.0 36267.0 37115.0 37126.1 37212.6 37362.3 31534.0 33290.5 33682.5 34085.8 34193.8 25273.9 25692.4 25912.4 25915.7 26059.2 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | [#2] jquery.html Cycles:180 Average:23247.52 Median:387.86 stddev:61472.34 (15849.0%) stddev-sans-first:61620.75 08:15:43 INFO - PROCESS | 14480 | Values: 352.7 353.3 356.5 368.7 377.5 15824.0 16403.8 16979.9 17016.0 17034.5 16071.8 16639.3 16894.2 17200.0 17208.1 4924.8 5148.8 5167.3 5172.7 5184.8 3064.3 3200.2 5021.1 5566.4 5882.9 5832.2 5863.2 5914.3 5923.1 5931.1 5683.3 5770.9 5839.9 5854.8 5860.4 2604.2 2742.4 2744.2 5089.9 5111.1 14717.4 20047.5 20047.7 21183.8 21383.0 1977.8 2176.8 2366.2 2378.5 2383.4 12580.4 12840.3 12954.4 13056.7 13504.0 1534.2 1545.8 1565.8 1573.7 1670.3 42596.6 42921.8 48793.0 65846.3 66260.0 9041.7 9104.3 9630.9 9648.3 9864.9 12562.1 12628.8 12654.8 12669.1 12677.9 7438.5 7489.5 7501.5 7676.1 7742.2 7482.9 7540.8 7543.2 7623.0 7687.5 6000.1 6034.8 6056.2 6100.6 6176.7 1511.8 1622.2 1626.9 1671.4 1719.9 360.8 786.2 834.6 843.9 851.8 10182.1 10715.6 10851.3 11072.9 11163.1 381.5 383.3 387.2 388.5 405.9 5865.8 5888.7 5915.5 5941.2 6007.9 293561.0 297057.0 410623.0 411977.0 418569.0 81633.6 83743.0 85451.6 86845.0 87972.6 941.8 957.3 960.2 960.7 971.6 15638.6 15876.4 15903.8 16410.0 16656.7 35211.6 36003.3 36071.8 37833.6 38199.6 51691.0 53430.5 53828.7 54186.7 54846.5 7545.1 7648.5 7712.7 7715.8 7953.5 11107.5 11163.2 11333.2 11790.7 12088.3 6502.8 8701.2 9803.0 10094.3 10287.6 10161.2 10400.9 10523.6 10773.3 10805.1 9978.4 10199.7 10238.4 10395.4 10427.5 7580.2 7736.6 7771.1 7786.0 8030.8 9681.5 10039.8 10097.8 10169.1 10254.6 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | [#3] mootools.html Cycles:180 Average:4962.07 Median:4861.95 stddev:2839.45 (58.4%) stddev-sans-first:2833.83 08:15:43 INFO - PROCESS | 14480 | Values: 1266.5 1368.4 1404.6 1471.5 1674.9 6494.1 7409.9 7635.2 7658.5 7826.6 7593.8 7721.7 7725.3 7737.0 7772.3 1804.1 1871.7 1873.8 2169.2 2201.4 1846.7 2113.9 2216.3 2217.9 2219.2 2144.4 2157.1 2182.8 2185.5 2196.7 1800.9 2168.6 2190.1 2192.3 2194.0 2094.9 2173.5 2173.9 2182.3 2183.6 7523.1 7554.4 7566.9 7573.9 7615.6 4268.5 4395.4 4414.7 4420.2 4428.8 2586.7 2659.7 2789.5 2805.6 2811.2 856.2 866.5 877.3 884.0 886.1 10025.8 10313.5 10345.3 10356.6 10366.2 4044.9 4048.9 4153.7 4156.0 4166.3 8760.6 8780.9 8786.4 8792.2 8794.0 4545.8 4549.2 4550.1 4556.0 4558.7 3434.5 3470.9 4116.3 4221.9 4227.1 3517.1 3563.2 3662.1 3669.2 3680.2 1122.9 1150.3 1157.6 1171.6 1177.5 649.5 787.0 787.6 792.3 798.4 4793.5 4964.3 5029.8 5036.2 5235.8 358.2 371.6 374.0 375.0 377.5 3177.1 3441.4 3446.6 3455.9 3462.2 9096.5 9480.0 9492.1 9543.7 9552.5 9431.6 9444.3 9448.9 9476.1 9478.2 7023.4 7233.3 7283.5 7308.5 7311.7 4930.4 5101.0 5103.3 5153.7 5257.4 8865.0 8909.9 8961.5 8969.0 8978.2 8380.3 8782.3 8815.5 8927.6 8943.4 5540.7 6365.5 6387.9 6471.7 6553.7 7252.9 7289.2 7336.7 7360.4 7409.1 6497.0 6650.9 6705.5 6739.9 6875.2 6426.0 6451.4 6473.7 6480.7 6527.2 5749.4 5803.3 5842.5 5896.9 5904.1 4045.1 4114.0 4212.0 4218.9 4242.7 4229.4 4295.6 4338.1 4397.5 4398.9 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | [#4] prototype.html Cycles:180 Average:4158.38 Median:4604.99 stddev:1204.19 (26.1%) stddev-sans-first:1172.05 08:15:43 INFO - PROCESS | 14480 | Values: 290.5 291.6 299.7 301.5 304.3 4816.4 4823.8 4844.8 4884.8 4891.4 4753.5 4848.0 4858.0 4862.5 4868.7 3572.4 3660.9 3789.9 3792.5 3810.4 3787.0 3793.1 3803.6 3814.4 3820.4 3724.5 3759.0 3777.9 3779.7 3779.8 3543.2 3660.3 3762.1 3772.8 3775.9 3314.5 3317.8 3317.8 3322.4 3323.9 4698.6 4702.8 4713.7 4715.0 4767.0 4162.3 4298.9 4304.6 4314.9 4345.4 5005.7 5030.4 5037.1 5041.2 5044.7 3607.2 3609.9 3615.7 3617.7 3641.8 5057.6 5237.5 5250.2 5254.2 5256.2 3691.4 3724.6 3728.6 3736.0 3740.6 3753.0 3754.5 3756.4 3811.2 3814.4 4274.8 4294.1 4313.0 4320.6 4328.5 4876.7 5034.8 5038.7 5058.6 5059.9 1299.5 1299.7 1302.3 1307.4 1311.4 810.4 824.2 844.2 850.7 851.3 4339.6 4460.3 4468.0 4479.7 4488.6 5191.7 5256.7 5265.4 5271.3 5279.3 4396.4 4421.4 4469.6 4516.5 4523.8 2646.6 2800.0 2810.8 2817.7 2833.9 4964.2 4965.9 4971.3 4981.3 4987.2 5287.4 5355.7 5416.8 5438.3 5442.3 4953.5 4955.3 4969.6 4990.4 4994.9 5265.7 5279.1 5314.9 5323.3 5342.7 5040.5 5195.4 5202.8 5215.5 5216.5 4911.6 4930.4 4949.0 4993.9 5005.9 3386.6 3426.8 3436.8 3437.3 3438.6 4551.9 4751.4 4818.1 4841.9 4848.7 4558.7 4572.0 4589.4 4604.5 4605.5 4593.6 4598.9 4604.3 4622.4 4625.0 4422.0 4529.3 4574.9 4617.9 4622.3 4678.9 4919.2 5038.2 5048.7 5050.2 4922.8 4954.7 4967.6 4994.6 4999.3 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - PROCESS | 14480 | [#5] yui.html Cycles:180 Average:15322.61 Median:595.43 stddev:21606.49 (3628.7%) stddev-sans-first:21638.52 08:15:43 INFO - PROCESS | 14480 | Values: 522.4 546.3 578.1 584.2 611.7 10381.7 10943.6 11341.8 11353.9 11379.0 11414.7 11725.1 11781.3 11802.1 11872.6 620.1 747.6 763.0 776.0 777.8 771.5 772.4 773.1 775.3 775.5 814.1 814.8 815.5 816.6 817.2 638.2 787.8 806.4 806.8 808.1 595.0 595.1 595.3 595.5 595.5 10770.9 10861.4 10886.1 10923.3 10924.9 11107.3 11464.6 11837.2 11853.3 12274.5 10756.7 10854.9 11066.6 11108.0 11236.4 3564.1 3566.6 3599.0 3611.5 3626.8 56321.7 57490.4 57968.0 57995.4 58604.0 9164.3 9399.8 9443.1 9787.6 9806.9 16579.3 16581.3 16585.8 16642.8 16747.2 6186.4 6257.2 6320.2 6484.1 6572.3 3505.1 3526.4 3541.2 3555.6 3603.5 2494.3 2582.2 2587.1 2592.5 3049.4 515.8 519.2 521.4 531.9 532.5 428.9 430.2 459.8 460.3 497.3 7218.4 7225.5 7432.8 7556.5 7752.1 433.9 487.6 511.5 531.9 542.4 3361.2 3429.5 3441.5 3484.4 3512.5 54604.5 55122.7 56291.4 56294.7 56313.4 52129.7 63706.7 72552.6 74123.3 84516.0 75209.0 78253.2 78405.6 79251.0 79455.2 6634.6 6679.6 6876.9 6878.5 6891.9 31293.1 41328.8 47540.0 48027.5 48058.8 58664.1 58799.0 66311.3 66495.0 66738.3 8866.8 9030.9 9039.8 9083.5 9242.5 9501.0 9703.6 9816.9 9863.6 10378.9 8960.0 8983.3 9043.4 9184.3 9488.9 8787.3 8818.2 8922.0 8955.7 9300.3 8792.4 8929.9 8949.9 8994.6 9440.3 7557.9 7695.0 7786.4 7914.0 7961.8 7815.1 7838.4 8003.3 8485.4 8505.5 08:15:43 INFO - PROCESS | 14480 | -------- Summary: end -------- 08:15:43 INFO - PROCESS | 14480 | 08:15:43 INFO - TEST-INFO | 14480: exit 0 08:15:43 INFO - TEST-OK | dromaeo_css | took 1119990ms 08:15:43 INFO - TEST-START | kraken 08:15:43 INFO - operating with platform_type : linux_ 08:15:43 INFO - Initialising browser for kraken test... 08:15:43 INFO - TEST-INFO | started process 14657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOp_OEH/profile http://localhost:34344/getInfo.html) 08:15:48 INFO - PROCESS | 14657 | __metrics Screen width/height:1600/1200 08:15:48 INFO - PROCESS | 14657 | colorDepth:24 08:15:48 INFO - PROCESS | 14657 | Browser inner width/height: 1024/697 08:15:48 INFO - PROCESS | 14657 | __metrics 08:15:49 ERROR - PROCESS | 14657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:49 INFO - PROCESS | 14657 | console.error: PushService: 08:15:49 INFO - PROCESS | 14657 | stateChangeProcessEnqueue: Error transitioning state 08:15:49 INFO - PROCESS | 14657 | UnknownError 08:15:50 INFO - TEST-INFO | 14657: exit 0 08:15:50 INFO - Browser initialized. 08:15:50 INFO - Running cycle 1/1 for kraken test... 08:15:50 INFO - TEST-INFO | started process 14739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOp_OEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:02 INFO - PROCESS | 14739 | RSS: Main: 175091712 08:16:02 INFO - PROCESS | 14739 | 08:16:05 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34344/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:06 INFO - PROCESS | 14739 | RSS: Main: 233050112 08:16:06 INFO - PROCESS | 14739 | 08:16:08 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34344/tests/kraken/driver.html?testName=audio-dft) 08:16:09 INFO - PROCESS | 14739 | RSS: Main: 221184000 08:16:09 INFO - PROCESS | 14739 | 08:16:12 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34344/tests/kraken/driver.html?testName=audio-fft) 08:16:13 INFO - PROCESS | 14739 | RSS: Main: 288227328 08:16:13 INFO - PROCESS | 14739 | 08:16:15 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34344/tests/kraken/driver.html?testName=audio-oscillator) 08:16:16 INFO - PROCESS | 14739 | RSS: Main: 197754880 08:16:16 INFO - PROCESS | 14739 | 08:16:18 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:19 INFO - PROCESS | 14739 | RSS: Main: 202035200 08:16:19 INFO - PROCESS | 14739 | 08:16:22 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34344/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:22 INFO - PROCESS | 14739 | RSS: Main: 239161344 08:16:22 INFO - PROCESS | 14739 | 08:16:26 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34344/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:26 INFO - PROCESS | 14739 | RSS: Main: 234278912 08:16:26 INFO - PROCESS | 14739 | 08:16:29 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34344/tests/kraken/driver.html?testName=json-parse-financial) 08:16:30 INFO - PROCESS | 14739 | RSS: Main: 236453888 08:16:30 INFO - PROCESS | 14739 | 08:16:32 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:32 INFO - PROCESS | 14739 | RSS: Main: 222539776 08:16:32 INFO - PROCESS | 14739 | 08:16:34 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:35 INFO - PROCESS | 14739 | RSS: Main: 226492416 08:16:35 INFO - PROCESS | 14739 | 08:16:37 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:38 INFO - PROCESS | 14739 | RSS: Main: 233078784 08:16:38 INFO - PROCESS | 14739 | 08:16:40 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:41 INFO - PROCESS | 14739 | RSS: Main: 239099904 08:16:41 INFO - PROCESS | 14739 | 08:16:44 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:45 INFO - PROCESS | 14739 | RSS: Main: 237821952 08:16:45 INFO - PROCESS | 14739 | 08:16:46 INFO - PROCESS | 14739 | Cycle 1(1): loaded http://localhost:34344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34344/tests/kraken/driver.html?testName=ai-astar) 08:16:47 INFO - PROCESS | 14739 | RSS: Main: 280625152 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | __start_tp_report 08:16:47 INFO - PROCESS | 14739 | _x_x_mozilla_page_load 08:16:47 INFO - PROCESS | 14739 | _x_x_mozilla_page_load_details 08:16:47 INFO - PROCESS | 14739 | |i|pagename|runs| 08:16:47 INFO - PROCESS | 14739 | |0;ai-astar;116;109;113;114;111;112;112;112;113;112 08:16:47 INFO - PROCESS | 14739 | |1;audio-beat-detection;154;141;137;192;132;159;153;132;187;132 08:16:47 INFO - PROCESS | 14739 | |2;audio-dft;163;160;160;162;163;161;162;161;163;162 08:16:47 INFO - PROCESS | 14739 | |3;audio-fft;75;76;76;126;76;76;75;77;100;75 08:16:47 INFO - PROCESS | 14739 | |4;audio-oscillator;87;86;120;87;87;87;126;87;86;133 08:16:47 INFO - PROCESS | 14739 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 08:16:47 INFO - PROCESS | 14739 | |6;imaging-darkroom;146;146;147;145;146;145;146;147;147;147 08:16:47 INFO - PROCESS | 14739 | |7;imaging-desaturate;95;96;95;95;95;96;95;96;96;95 08:16:47 INFO - PROCESS | 14739 | |8;json-parse-financial;62;63;64;64;63;65;63;63;62;64 08:16:47 INFO - PROCESS | 14739 | |9;json-stringify-tinderbox;64;64;65;65;65;65;65;65;65;64 08:16:47 INFO - PROCESS | 14739 | |10;stanford-crypto-aes;84;84;83;83;84;84;84;84;121;84 08:16:47 INFO - PROCESS | 14739 | |11;stanford-crypto-ccm;135;149;140;140;147;129;132;140;133;135 08:16:47 INFO - PROCESS | 14739 | |12;stanford-crypto-pbkdf2;168;168;168;168;168;166;172;166;167;168 08:16:47 INFO - PROCESS | 14739 | |13;stanford-crypto-sha256-iterative;67;66;66;72;66;67;67;65;65;66 08:16:47 INFO - PROCESS | 14739 | __end_tp_report 08:16:47 INFO - PROCESS | 14739 | __start_cc_report 08:16:47 INFO - PROCESS | 14739 | _x_x_mozilla_cycle_collect,1876 08:16:47 INFO - PROCESS | 14739 | __end_cc_report 08:16:47 INFO - PROCESS | 14739 | __startTimestamp1465485407050__endTimestamp 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | ------- Summary: start ------- 08:16:47 INFO - PROCESS | 14739 | Number of tests: 14 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:1.84 (1.6%) stddev-sans-first:1.41 08:16:47 INFO - PROCESS | 14739 | Values: 116.0 109.0 113.0 114.0 111.0 112.0 112.0 112.0 113.0 112.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:153.50 stddev:22.17 (14.4%) stddev-sans-first:23.51 08:16:47 INFO - PROCESS | 14739 | Values: 154.0 141.0 137.0 192.0 132.0 159.0 153.0 132.0 187.0 132.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 08:16:47 INFO - PROCESS | 14739 | Values: 163.0 160.0 160.0 162.0 163.0 161.0 162.0 161.0 163.0 162.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:16.87 (22.2%) stddev-sans-first:17.63 08:16:47 INFO - PROCESS | 14739 | Values: 75.0 76.0 76.0 126.0 76.0 76.0 75.0 77.0 100.0 75.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:87.00 stddev:19.39 (22.3%) stddev-sans-first:20.10 08:16:47 INFO - PROCESS | 14739 | Values: 87.0 86.0 120.0 87.0 87.0 87.0 126.0 87.0 86.0 133.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:16:47 INFO - PROCESS | 14739 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 08:16:47 INFO - PROCESS | 14739 | Values: 146.0 146.0 147.0 145.0 146.0 145.0 146.0 147.0 147.0 147.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:16:47 INFO - PROCESS | 14739 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 08:16:47 INFO - PROCESS | 14739 | Values: 62.0 63.0 64.0 64.0 63.0 65.0 63.0 63.0 62.0 64.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 08:16:47 INFO - PROCESS | 14739 | Values: 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.00 stddev:11.78 (14.0%) stddev-sans-first:12.42 08:16:47 INFO - PROCESS | 14739 | Values: 84.0 84.0 83.0 83.0 84.0 84.0 84.0 84.0 121.0 84.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:140.00 stddev:6.45 (4.6%) stddev-sans-first:6.75 08:16:47 INFO - PROCESS | 14739 | Values: 135.0 149.0 140.0 140.0 147.0 129.0 132.0 140.0 133.0 135.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 08:16:47 INFO - PROCESS | 14739 | Values: 168.0 168.0 168.0 168.0 168.0 166.0 172.0 166.0 167.0 168.0 08:16:47 INFO - PROCESS | 14739 | 08:16:47 INFO - PROCESS | 14739 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:2.00 (3.0%) stddev-sans-first:2.12 08:16:47 INFO - PROCESS | 14739 | Values: 67.0 66.0 66.0 72.0 66.0 67.0 67.0 65.0 65.0 66.0 08:16:47 INFO - PROCESS | 14739 | -------- Summary: end -------- 08:16:47 INFO - PROCESS | 14739 | 08:16:48 INFO - TEST-INFO | 14739: exit 0 08:16:48 INFO - TEST-OK | kraken | took 64290ms 08:16:48 INFO - SUITE-END | took 1184s 08:16:48 INFO - Completed test suite (00:19:44) 08:16:48 INFO - javascript benchmark 08:16:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.231751633268, 2627.382565097203, 2645.7751091157243, 2658.8936442542285, 2667.199840047985, 4632.559906808856, 4686.929696054562, 4730.834420795269, 4783.856484305472, 4854.854354369366, 4715.811367545294, 4735.171345014626, 4741.620670346372, 4797.136515427222, 4805.038992201565, 4362.738235705852, 4394.3188805735, 4398.802053907574, 4416.447944006999, 4419.0499042705815, 4361.171377438277, 4467.374567560544, 4490.775461226942, 4497.145542346943, 4532.682712210147, 4434.224010798098, 4477.708948918326, 4492.887677808081, 4496.168208881368, 4519.615832654228, 4290.227759003378, 4318.956810431887, 4330.523642399334, 4338.414314067592, 4356.172327257811, 4288.099499105192, 4308.569143085698, 4357.36818161368, 4365.301551751736, 4397.1865204937185, 4772.570468657837, 4777.761111944389, 4806.447258565275, 4834.3473631059705, 4836.371271734652, 4959.528844759742, 5012.649114561982, 5038.420581633122, 5069.315642388267, 5095.949040509585, 5110.97444512775, 5160.432352441228, 5163.845084647466, 5172.405173405069, 5181.53366197044, 4598.0803839232285, 4769.165396055676, 4797.40032495938, 4813.302071199656, 4817.566419022235, 5155.7679904404395, 5193.195054766517, 5203.791848326025, 5215.55667768244, 5270.8155214567305, 5022.924656130161, 5028.296038554606, 5032.622553308516, 5048.116579598555, 5048.444671086178, 4944.826931057396, 4994.450610432849, 5053.191489361758, 5053.292539044537, 5077.136886729265, 4950.801967921315, 4971.229459433794, 4989.90020199594, 4992.475790042066, 5041.168207245837, 4954.826581069718, 4965.950340496549, 4965.950340496621, 4968.22992436173, 5018.397792264952, 4185.769782661982, 4233.661307095425, 4267.554328597657, 4267.701260911706, 4308.246056940023, 3753.0242137044565, 3759.6804271637216, 3767.0, 3795.69634429245, 3848.3842585186235, 4350.564943505624, 4363.127374525107, 4364.323529852878, 4405.867823965286, 4408.625266852354, 5013.097642424325, 5018.548330650186, 5068.4424713281505, 5134.460881607378, 5180.456052114474, 4316.352547117895, 4342.41377414045, 4345.239583072949, 4385.342198670161, 4388.166248412791, 4582.495925448198, 4587.541245875453, 4591.288350305708, 4592.15045216636, 4635.397398338262, 4669.229577119737, 4744.857654270378, 4780.569748722632, 4796.112719146969, 4802.135615589227, 5082.186850103965, 5098.796048158032, 5100.897982040264, 5104.183330667075, 5141.203113517411, 4743.549362810528, 4779.30700048498, 4787.257975013878, 4789.3055506952, 4827.396575428072, 4953.2074868020945, 4970.3290055842, 5006.849794506171, 5045.091883460866, 5060.84817455477, 5114.156164233009, 5124.077666020152, 5137.1010073237785, 5137.44481552073, 5144.074066668036, 4970.453250142409, 4983.352164218629, 4985.177445721561, 4986.252062190701, 5022.974885125551, 4863.027394521039, 4897.0450762101045, 4929.06347793918, 4976.776045078052, 4986.650934434555, 4873.171560834596, 4904.239842824368, 4913.484084171254, 4934.901301973869, 4961.776720047678, 4854.150523658416, 5009.699418034929, 5010.198368261061, 5046.747662616928, 5060.063888180698, 4717.764111794465, 4757.952420475751, 4861.878453038702, 4885.169521181337, 4885.2427873679635], "value": 4666.912726165891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9838142153412, 580.5761793890459, 580.9506191973682, 584.7368684092158, 591.9556033297501, 27178.0, 39457.210855782905, 41138.0, 41255.17489650205, 44573.33140002895, 41645.791771041106, 42094.57905420945, 42108.57891421085, 42111.57888421115, 42158.57841421585, 7539.434542409341, 7687.0391201099865, 7831.334336581397, 7840.960795196016, 7841.294283514482, 7501.849963000764, 7711.768646940601, 7715.498492597963, 9936.254780891426, 10119.291649584533, 10053.849192262085, 10110.393376397404, 10116.19070474364, 10120.493975301242, 10123.341982771097, 9997.750056248578, 10025.298229123964, 10048.346857454315, 10051.89948100517, 10062.295639305288, 7461.403087753021, 9683.467409292487, 10014.298999070068, 10017.599296028151, 10341.121004714609, 38693.0, 39388.60611393878, 39459.60540394588, 39459.8027009866, 39497.0, 2763.1296141715297, 2792.8184667996516, 2890.713632433568, 3130.9217269568217, 3248.431524483206, 29897.551536726965, 30539.847300763577, 30585.235369115726, 30670.233244168852, 31105.222369440944, 3326.248829570611, 3461.8615255389755, 3469.0, 3530.082178633548, 3597.0467826026124, 261299.0, 262993.68503157556, 263573.0, 264090.0, 264538.0, 50472.242916356285, 50747.49252507502, 50992.74503627458, 51080.0, 51081.48918510842, 33341.83329083339, 34135.829320853234, 34148.0, 35864.64135358665, 59372.0, 15374.692506149815, 15452.5364239073, 15493.302801373966, 15493.535193944199, 15514.301856416489, 10792.352458852494, 12156.331401772988, 12251.203671761306, 12256.264624122581, 12270.509179632714, 18016.189271482814, 18541.16564754589, 18553.165107570192, 19354.612907741765, 19398.515037123903, 6742.797716068526, 6872.450203983669, 6883.931160688329, 6910.896336554955, 7173.820654483576, 776.2237762237762, 862.7886167888907, 894.3113802372137, 911.0206527982313, 951.1629765806184, 27725.58411623827, 28316.43367132687, 28752.281192969924, 29074.70925290762, 29104.85447572791, 962.6775030364767, 984.8621193032981, 1025.1849779425374, 1027.440045175381, 1054.0092313225543, 15275.847241527443, 15350.692986140215, 15423.460178893909, 15580.0, 15587.454439094578, 385397.0, 389152.0, 389212.0, 389422.0, 391673.0, 51443.228351574755, 51886.22170667443, 51910.0, 51941.0, 51982.0, 1012.6202673997251, 1123.2025262064026, 1175.1127898436625, 1178.7406770510474, 1187.186777057701, 26797.464050718485, 29352.412951741273, 29577.26056848596, 30108.849455753458, 30365.69634303717, 44068.55931440645, 44485.55329456911, 44510.3323450155, 44580.33129503125, 44604.0, 300804.0, 301742.0, 302174.0, 302644.0, 302973.0, 20187.697184542536, 25288.36779080464, 25772.09797657073, 26220.475590488466, 26316.868415658566, 42938.35592466178, 43294.56705433031, 43350.78324608357, 44104.77947610241, 44403.33394999142, 35111.0, 35346.0, 36374.90875273746, 36423.81788091043, 36455.27089458143, 36344.27311453809, 36640.81679591585, 36760.81619591885, 36871.63128368682, 37231.0, 36267.0, 37115.0, 37126.07184820401, 37212.627873722, 37362.25275494529, 31534.0, 33290.5006424899, 33682.494762579074, 34085.82957085199, 34193.82903085568, 25273.87363063173, 25692.357691057125, 25912.352191195372, 25915.740842591335, 26059.21822345333], "value": 17993.483473659646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.73721077797046, 353.288124429275, 356.54718507495477, 368.71793078295093, 377.464001118412, 15824.0, 16403.835961640394, 16979.91510042448, 17016.0, 17034.488965331046, 16071.839281607181, 16639.33442662292, 16894.239759210835, 17200.0, 17208.13959302036, 4924.827631032915, 5148.845534633948, 5167.276581278624, 5172.741362931857, 5184.844454666347, 3064.34116664917, 3200.1679563313473, 5021.1213037718435, 5566.415526369713, 5882.941170588282, 5832.1834943108, 5863.208466856983, 5914.349421563625, 5923.08192230205, 5931.110333449996, 5683.3464151622475, 5770.855728606797, 5839.883202335972, 5854.76580936762, 5860.443257890493, 2604.231751633273, 2742.3829638331417, 2744.2316151477617, 5089.898202035975, 5111.131107711698, 14717.411303547846, 20047.49881252966, 20047.699284510745, 21183.788162118337, 21383.0, 1977.812107849752, 2176.836737244713, 2366.2073205476186, 2378.54807586558, 2383.41606306456, 12580.370981450891, 12840.293783841886, 12954.417051232716, 13056.738865222642, 13504.0, 1534.2022148482727, 1545.8299587045417, 1565.7865154505237, 1573.6695293988275, 1670.3485640600175, 42596.57403425988, 42921.785391072845, 48793.0, 65846.34153658402, 66260.0, 9041.728748137566, 9104.31717621181, 9630.903690963141, 9648.324617276723, 9864.852027219598, 12562.120651554485, 12628.81056784149, 12654.81017784734, 12669.113162078565, 12677.936610316889, 7438.516496427715, 7489.475736698488, 7501.474896757284, 7676.11724651661, 7742.187070357644, 7482.85034299311, 7540.773776786705, 7543.170251272356, 7623.047119110111, 7687.5387476751575, 6000.129981152709, 6034.762873610987, 6056.182415373956, 6100.633961962297, 6176.66028368444, 1511.8185817701726, 1622.245655770049, 1626.8942518736244, 1671.4484220207303, 1719.9312027518758, 360.7727131906934, 786.1509569664748, 834.6077343648476, 843.8944982073381, 851.82537579796, 10182.134518566005, 10715.624953126604, 10851.294665846695, 11072.944635276772, 11163.051140652973, 381.54214942069626, 383.25648242409636, 387.19656712322046, 388.52987884659876, 405.8701215610976, 5865.794697185578, 5888.705564721747, 5915.467607915309, 5941.168236446901, 6007.879842403127, 293561.0, 297057.0, 410623.0, 411977.0, 418569.0, 81633.59183204046, 83743.0, 85451.57274213589, 86845.0, 87972.5601371989, 941.8304705153001, 957.2676902169845, 960.2462067277154, 960.6877764726491, 971.601643326247, 15638.592526672654, 15876.444324448588, 15903.761443578123, 16410.0, 16656.666866662355, 35211.64788352186, 36003.27993440064, 36071.81964090268, 37833.62166378411, 38199.61800382072, 51691.0, 53430.4656953441, 53828.730856345464, 54186.72906635442, 54846.451535484135, 7545.132309784225, 7648.541087534543, 7712.730054448068, 7715.807104822425, 7953.5227886327, 11107.500162492868, 11163.218574699693, 11333.150013749168, 11790.705232369259, 12088.335141566946, 6502.837429064311, 8701.216890479887, 9803.0, 10094.293399461967, 10287.588496460357, 10161.237907157141, 10400.895991039994, 10523.631672891412, 10773.299735517166, 10805.135589153006, 9978.401295922267, 10199.7450063749, 10238.385696858213, 10395.428251445941, 10427.478626068514, 7580.166181720117, 7736.5687347838575, 7771.106322772954, 7785.961070194613, 8030.759077227693, 9681.467519286507, 10039.799204015733, 10097.848532271875, 10169.084782369622, 10254.58981640726], "value": 7770.533844224863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.512392728799, 1368.3773882883286, 1404.606710121166, 1471.5364660132057, 1674.891132076415, 6494.123293355401, 7409.8518029639445, 7635.198304178065, 7658.54048757075, 7826.5695386753705, 7593.810154746134, 7721.652525636346, 7725.304722574967, 7737.032870891138, 7772.261635144667, 1804.124999375302, 1871.6631006418838, 1873.812618738129, 2169.154029928325, 2201.3506015725397, 1846.7322238275442, 2113.92601258956, 2216.2686313516583, 2217.855839370444, 2219.178903805594, 2144.378130342199, 2157.0508976050564, 2182.847200695952, 2185.4645611825044, 2196.6595177747477, 1800.9459716208535, 2168.5554461335387, 2190.0582749417745, 2192.3203806819856, 2193.967090493644, 2094.916203351864, 2173.500094978164, 2173.945651358713, 2182.301663467691, 2183.5960347335795, 7523.0972283326355, 7554.395648348119, 7566.886496702554, 7573.886391704129, 7615.5811430371305, 4268.509121451042, 4395.362672412514, 4414.735115893057, 4420.248557745191, 4428.848499390149, 2586.6766654168227, 2659.6675415573054, 2789.497890379731, 2805.579163125527, 2811.1847564206355, 856.2336708645727, 866.540733411293, 877.2893955895681, 883.9911600884037, 886.0607755778894, 10025.799484010351, 10313.48432578368, 10345.327553708985, 10356.637517686844, 10366.170706343475, 4044.9078748737675, 4048.9190216196102, 4153.7300075494995, 4156.044109854751, 4166.250074986471, 8760.605772740242, 8780.912190878009, 8786.384953053353, 8792.164744349277, 8793.988691300454, 4545.772711364419, 4549.181147393435, 4550.067236216568, 4556.0, 4558.749268790249, 3434.5363375944426, 3470.9305813884084, 4116.341385378385, 4221.936670949938, 4227.133437645275, 3517.120719820045, 3563.1804684922095, 3662.08447888028, 3669.1927775889794, 3680.208755117609, 1122.9113848242264, 1150.2753265442718, 1157.5890558851654, 1171.6016554371554, 1177.5054477119631, 649.5128653509868, 786.9685212591547, 787.6022608582629, 792.3186059988406, 798.4211446701095, 4793.49668284832, 4964.255361695702, 5029.84910452687, 5036.194208926554, 5235.769594145373, 358.18870258863694, 371.6209466344314, 374.04431677064815, 375.03615707631127, 377.4941578285111, 3177.132612917674, 3441.3633477806184, 3446.5691788526433, 3455.913602159966, 3462.1690794209712, 9096.454212747256, 9480.0, 9492.098250666175, 9543.713688589354, 9552.474613896164, 9431.62273509052, 9444.291678124031, 9448.90551094494, 9476.147146756686, 9478.241740660731, 7023.403010744144, 7233.312835280745, 7283.4537409694485, 7308.5249458786075, 7311.707531698672, 4930.403658778996, 5101.036101101028, 5103.2975764798475, 5153.742312884266, 5257.4216836147225, 8865.0, 8909.866352004854, 8961.507117108622, 8968.955155224183, 8978.191962723386, 8380.287675547646, 8782.29741620656, 8815.471071735716, 8927.553622318988, 8943.37396382247, 5540.722963851872, 6365.490760739222, 6387.9459889119635, 6471.708773105316, 6553.672316384066, 7252.89120663201, 7289.16174639902, 7336.669849856663, 7360.4479664026485, 7409.110906691231, 6497.0, 6650.866982660416, 6705.4635629150525, 6739.865202695821, 6875.174979002351, 6425.967870160619, 6451.3548645135115, 6473.741050358121, 6480.70836812354, 6527.184101987252, 5749.425057494217, 5803.332616749128, 5842.474177324061, 5896.8820623586425, 5904.114382842608, 4045.1100757834406, 4114.0, 4211.978940105279, 4218.873433796991, 4242.681798865159, 4229.435393328535, 4295.570442955679, 4338.067315527177, 4397.472303323621, 4398.868033958986], "value": 3903.429033738448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.5423957267304, 291.5844920987592, 299.71676765456647, 301.49951081205205, 304.34413838178705, 4816.397950256218, 4823.83116590919, 4844.757762111898, 4884.804607815688, 4891.388576427947, 4753.524647535253, 4848.030393921221, 4857.9757101214445, 4862.465128835825, 4868.683535570194, 3572.3926932421423, 3660.926781464369, 3789.905252368685, 3792.5448946126503, 3810.4474851146565, 3786.9810650946706, 3793.070697679059, 3803.619638036202, 3814.370628846237, 3820.36963900956, 3724.5344331958504, 3758.9812050939845, 3777.9032636886654, 3779.6976241900584, 3779.79211143387, 3543.2204914918675, 3660.2862441823854, 3762.1159027628487, 3772.8113594320175, 3775.9056023599355, 3314.5028245763087, 3317.800931944067, 3317.834108294576, 3322.3853587086223, 3323.933521329584, 4698.553637404441, 4702.835400760991, 4713.6936099153445, 4714.986277950257, 4767.022760334124, 4162.313218318974, 4298.935515967263, 4304.634106100985, 4314.892127696801, 4345.391645169679, 5005.724685142316, 5030.446650868402, 5037.143685573461, 5041.19340905457, 5044.6973181608855, 3607.1703508193, 3609.855605775792, 3615.7468977171607, 3617.7105831533677, 3641.8361173747244, 5057.645964782467, 5237.450067742909, 5250.159974404077, 5254.21186821976, 5256.159014557652, 3691.3540130477595, 3724.5902950675404, 3728.5712143103347, 3736.001239336996, 3740.5698344690163, 3753.042974041602, 3754.4931434256573, 3756.3938618926136, 3811.1805961718364, 3814.408766641175, 4274.764887931132, 4294.141171765659, 4312.978435107804, 4320.567943205717, 4328.458942632171, 4876.707397556158, 5034.79860805571, 5038.722870242172, 5058.570021548209, 5059.9121188944555, 1299.5451591942744, 1299.6815780133738, 1302.3423171298434, 1307.3920626908532, 1311.4098655605017, 810.4084018666407, 824.2293455619016, 844.2317491083207, 850.7235148576738, 851.3146916731966, 4339.5660433956355, 4460.301517581816, 4468.0, 4479.664025198123, 4488.58609538001, 5191.714455704972, 5256.710880901587, 5265.368155821326, 5271.341082364705, 5279.340082489689, 4396.362527433568, 4421.40311058003, 4469.575390337913, 4516.480604730498, 4523.773811309421, 2646.5897785843226, 2800.019993002433, 2810.775137988956, 2817.690054094048, 2833.8724757385553, 4964.230544265644, 4965.875853103701, 4971.304017437562, 4981.302617633534, 4987.1771157759285, 5287.365516138088, 5355.732213389315, 5416.8104116355735, 5438.320209973754, 5442.292501974718, 4953.50464953509, 4955.306257124005, 4969.627277954096, 4990.351254336913, 4994.850154495371, 5265.736713164403, 5279.128943724396, 5314.867128321823, 5323.281357016908, 5342.652727572696, 5040.470750571138, 5195.402528709247, 5202.843914682566, 5215.530602245816, 5216.504432078947, 4911.557959783494, 4930.359053323188, 4949.020391843292, 4993.850184494471, 5005.874853128701, 3386.627470978141, 3426.794392336468, 3436.7937923724658, 3437.2781715839956, 3438.621751607371, 4551.864232957512, 4751.358566593465, 4818.10864989978, 4841.9031619366715, 4848.684835485682, 4558.72063968016, 4571.954280457153, 4589.426321709786, 4604.470485894165, 4605.516420775771, 4593.6095431887325, 4598.88502787433, 4604.3323718061365, 4622.375979242759, 4625.028743963805, 4421.965895688019, 4529.252673308867, 4574.908501830011, 4617.884552886205, 4622.260438329851, 4678.883027924193, 4919.188333925005, 5038.2190760432195, 5048.697078175174, 5050.191969284897, 4922.803087876445, 4954.727489988085, 4967.552920237196, 4994.550490455877, 4999.250112483157], "value": 3775.980314700359, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.4435975685894, 546.3034630845674, 578.1270281874368, 584.1675612252541, 611.7155522681952, 10381.740456488591, 10943.616973405913, 11341.829872551907, 11353.943230283838, 11379.0, 11414.7146321342, 11725.120615953794, 11781.29312241266, 11802.114841386887, 11872.584459543918, 620.1194304088183, 747.6486051555787, 762.973295934641, 775.9922400776005, 777.7899967008905, 771.5447885747408, 772.3782355204058, 773.1456740301969, 775.3177204060419, 775.4726785785664, 814.1166833985104, 814.7840822182127, 815.5473712089788, 816.5753808019826, 817.2236375443323, 638.2181827261613, 787.8424315136996, 806.4314658165979, 806.8426656801926, 808.0949336742827, 594.9583529152961, 595.1043679262725, 595.330253464852, 595.5295316699802, 595.5354823237882, 10770.892291077067, 10861.40262285574, 10886.129109671207, 10923.289986150874, 10924.945375273152, 11107.333559986426, 11464.598739044177, 11837.230580012272, 11853.288802671867, 12274.509019639203, 10756.731081723019, 10854.945725271402, 11066.612668556561, 11108.0, 11236.438178091063, 3564.0733409313507, 3566.589842168132, 3599.0, 3611.5485564304463, 3626.8367923443507, 56321.71839140819, 57490.42509574934, 57968.0, 57995.42004579942, 58604.0, 9164.312676549285, 9399.812003760024, 9443.055694430503, 9787.608495660237, 9806.852897206547, 16579.336826527044, 16581.336746530003, 16585.83414165867, 16642.83357166437, 16747.1626418681, 6186.412290832363, 6257.217847769029, 6320.178376810985, 6484.059811327331, 6572.309907459744, 3505.1412403961194, 3526.4005119129297, 3541.1855273287288, 3555.6444355564754, 3603.5046554005353, 2494.3390001649577, 2582.1607977407416, 2587.107447930461, 2592.468543948524, 3049.35963447674, 515.7833709841875, 519.2470917170118, 521.3863093724915, 531.9361676598833, 532.4994505165132, 428.8520460441143, 430.2202529892887, 459.7586267209742, 460.2650968927138, 497.2963256991389, 7218.386437152901, 7225.494215404871, 7432.814179645444, 7556.546607203585, 7752.147263800977, 433.9127110608001, 487.5514526635504, 511.53961434708316, 531.9148936170222, 542.4494138449477, 3361.2269178088686, 3429.53701250333, 3441.5353927219503, 3484.3902317094407, 3512.473129030615, 54604.45395545994, 55122.72438637861, 56291.43708562944, 56294.71852640792, 56313.43686563164, 52129.739351303004, 63706.6814665933, 72552.63723681348, 74123.25876741164, 84516.0, 75209.0, 78253.2174678246, 78405.60797195978, 79250.99999999885, 79455.20544794478, 6634.635095069818, 6679.599224046573, 6876.931230687629, 6878.518503704692, 6891.896621550781, 31293.061208163792, 41328.79335603303, 47539.967406192714, 48027.5197248023, 48058.75970620124, 58664.120038198605, 58799.0, 66311.33688663051, 66495.0, 66738.33261667321, 8866.822663546563, 9030.90969090327, 9039.774005649648, 9083.500407477652, 9242.491662958602, 9501.04989501072, 9703.6118555257, 9816.85274720894, 9863.556139973862, 10378.896211037792, 8960.0, 8983.326250531367, 9043.366964312436, 9184.265258779415, 9488.85766713486, 8787.253083487974, 8818.162274583905, 8922.0, 8955.686550970684, 9300.348975571645, 8792.384533082623, 8929.866052009094, 8949.865752013595, 8994.595243214202, 9440.33917625787, 7557.924420755942, 7695.0, 7786.357143570745, 7914.0, 7961.840763184588, 7815.062192536932, 7838.372930165687, 8003.31971782405, 8485.448445851, 8505.489670619783], "value": 5805.826274712234, "unit": "score"}], "name": "dromaeo_css", "value": 6182.508904897623, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 113.0, 114.0, 111.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 141.0, 137.0, 192.0, 132.0, 159.0, 153.0, 132.0, 187.0, 132.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 162.0, 163.0, 161.0, 162.0, 161.0, 163.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 126.0, 76.0, 76.0, 75.0, 77.0, 100.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 120.0, 87.0, 87.0, 87.0, 126.0, 87.0, 86.0, 133.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 64.0, 63.0, 65.0, 63.0, 63.0, 62.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 84.0, 84.0, 84.0, 84.0, 121.0, 84.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 149.0, 140.0, 140.0, 147.0, 129.0, 132.0, 140.0, 133.0, 135.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 168.0, 168.0, 166.0, 172.0, 166.0, 167.0, 168.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 72.0, 66.0, 67.0, 67.0, 65.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1554.4, "alertThreshold": 2.0}]} 08:16:48 INFO - Return code: 0 08:16:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:16:48 ERROR - # TBPL SUCCESS # 08:16:48 INFO - Running post-action listener: _resource_record_post_action 08:16:48 INFO - ##### 08:16:48 INFO - ##### Finished run-tests step (success) 08:16:48 INFO - ##### 08:16:48 INFO - Running post-run listener: _resource_record_post_run 08:16:48 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 531755008; Read time: 24; Write time: 560860 08:16:48 INFO - TinderboxPrint: CPU usage
13.2% 08:16:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 08:16:48 INFO - TinderboxPrint: I/O write bytes / time
531,755,008 / 560,860 08:16:48 INFO - TinderboxPrint: CPU idle
8,318.3 (86.8%) 08:16:48 INFO - TinderboxPrint: CPU user
1,218.7 (12.7%) 08:16:48 INFO - TinderboxPrint: Swap in / out
0 / 0 08:16:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249831424; Read time: 0; Write time: 296128 08:16:48 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281923584; Read time: 24; Write time: 264732 08:16:48 INFO - Running post-run listener: _upload_blobber_files 08:16:48 INFO - Blob upload gear active. 08:16:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:16:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:16:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:16:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:16:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:50 INFO - (blobuploader) - INFO - Done attempting. 08:16:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:16:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:16:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:50 INFO - (blobuploader) - INFO - Done attempting. 08:16:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:16:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:55 INFO - (blobuploader) - INFO - Done attempting. 08:16:55 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:55 INFO - Return code: 0 08:16:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:16:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076530f9e51a4f86f984069fa6003739e2cec25fec9acd8fac064d455bfac1fda6a37055ad2a2a768ca2afe88b00bba815ded95825fef824879a56ac0a21ac2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4f4a073e7f7c43b3095224e4106a640631530644dc40a4b03d9c13c1d288bed3319ed0a7a334b4d52321c85cd96efadbc5879a40e98a1ff34d34ce86c7917f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43133dc8061c6ab01b61fdea05685a4c2ff9b60192b1763559077d2caf9e062c81f814636a66916e423cf78c019d5397c75eeb92b3f8840a308b744de86a6868"} 08:16:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:16:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:16:55 INFO - Contents: 08:16:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076530f9e51a4f86f984069fa6003739e2cec25fec9acd8fac064d455bfac1fda6a37055ad2a2a768ca2afe88b00bba815ded95825fef824879a56ac0a21ac2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4f4a073e7f7c43b3095224e4106a640631530644dc40a4b03d9c13c1d288bed3319ed0a7a334b4d52321c85cd96efadbc5879a40e98a1ff34d34ce86c7917f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43133dc8061c6ab01b61fdea05685a4c2ff9b60192b1763559077d2caf9e062c81f814636a66916e423cf78c019d5397c75eeb92b3f8840a308b744de86a6868"} 08:16:55 INFO - Running post-run listener: copy_logs_to_upload_dir 08:16:55 INFO - Copying logs to upload dir... 08:16:55 INFO - mkdir: /builds/slave/test/build/upload/logs 08:16:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.158025 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-09 08:16:55.157912) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:16:55.161655) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076530f9e51a4f86f984069fa6003739e2cec25fec9acd8fac064d455bfac1fda6a37055ad2a2a768ca2afe88b00bba815ded95825fef824879a56ac0a21ac2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4f4a073e7f7c43b3095224e4106a640631530644dc40a4b03d9c13c1d288bed3319ed0a7a334b4d52321c85cd96efadbc5879a40e98a1ff34d34ce86c7917f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43133dc8061c6ab01b61fdea05685a4c2ff9b60192b1763559077d2caf9e062c81f814636a66916e423cf78c019d5397c75eeb92b3f8840a308b744de86a6868"} build_url:https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/TJ9xqX2AQ2-l994-pAUH6Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/076530f9e51a4f86f984069fa6003739e2cec25fec9acd8fac064d455bfac1fda6a37055ad2a2a768ca2afe88b00bba815ded95825fef824879a56ac0a21ac2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4f4a073e7f7c43b3095224e4106a640631530644dc40a4b03d9c13c1d288bed3319ed0a7a334b4d52321c85cd96efadbc5879a40e98a1ff34d34ce86c7917f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43133dc8061c6ab01b61fdea05685a4c2ff9b60192b1763559077d2caf9e062c81f814636a66916e423cf78c019d5397c75eeb92b3f8840a308b744de86a6868"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:16:55.187348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:16:55.187668) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465484168.856867-1852475724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:16:55.270236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:16:55.270562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:16:55.270858) ========= ========= Total master_lag: 0.16 =========