builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1461058633.28 results: success (0) buildid: 20160419015854 builduid: 8bab387cbe944959afbb15c00274247e revision: d4b74afcc60b937f25d54f365be46a8133980209 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.277436) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.277856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.278147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.318572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.318862) ========= 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=af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 02:37:13-- 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% 43.2M=0s 2016-04-19 02:37:13 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.413815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.414142) ========= 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=af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016036 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.478852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:13.479259) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d4b74afcc60b937f25d54f365be46a8133980209 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d4b74afcc60b937f25d54f365be46a8133980209 --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=af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 02:37:14,083 truncating revision to first 12 chars 2016-04-19 02:37:14,083 Setting DEBUG logging. 2016-04-19 02:37:14,083 attempt 1/10 2016-04-19 02:37:14,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d4b74afcc60b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 02:37:14,466 unpacking tar archive at: fx-team-d4b74afcc60b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:14.167189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:14.167589) ========= script_repo_revision: d4b74afcc60b937f25d54f365be46a8133980209 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:14.168002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:14.168328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 02:37:14.177532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-19 02:37:14.177856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:37:14 INFO - MultiFileLogger online at 20160419 02:37:14 in /builds/slave/test 02:37:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:37:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:14 INFO - {'append_to_log': False, 02:37:14 INFO - 'base_work_dir': '/builds/slave/test', 02:37:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:37:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:14 INFO - 'branch': 'Fx-Team-Non-PGO', 02:37:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:14 INFO - 'config_files': ('talos/linux_config.py',), 02:37:14 INFO - 'default_actions': ('clobber', 02:37:14 INFO - 'read-buildbot-config', 02:37:14 INFO - 'download-and-extract', 02:37:14 INFO - 'populate-webroot', 02:37:14 INFO - 'create-virtualenv', 02:37:14 INFO - 'install', 02:37:14 INFO - 'run-tests'), 02:37:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:14 INFO - 'download_minidump_stackwalk': True, 02:37:14 INFO - 'download_symbols': 'ondemand', 02:37:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:14 INFO - 'installer_path': 'installer.exe', 02:37:14 INFO - 'log_level': 'info', 02:37:14 INFO - 'log_name': 'talos', 02:37:14 INFO - 'log_to_console': True, 02:37:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:37:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:37:14 INFO - 'opt_config_files': (), 02:37:14 INFO - 'pip_index': False, 02:37:14 INFO - 'sps_profile': False, 02:37:14 INFO - 'sps_profile_interval': 0, 02:37:14 INFO - 'suite': 'dromaeojs', 02:37:14 INFO - 'system_bits': '32', 02:37:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:14 INFO - 'title': 'talos-linux64-ix-020', 02:37:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:14 INFO - 'use_talos_json': True, 02:37:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:14 INFO - 'work_dir': 'build'} 02:37:14 INFO - ##### 02:37:14 INFO - ##### Running clobber step. 02:37:14 INFO - ##### 02:37:14 INFO - Running pre-action listener: _resource_record_pre_action 02:37:14 INFO - Running main action method: clobber 02:37:14 INFO - rmtree: /builds/slave/test/build 02:37:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:37:15 INFO - Running post-action listener: _resource_record_post_action 02:37:15 INFO - ##### 02:37:15 INFO - ##### Running read-buildbot-config step. 02:37:15 INFO - ##### 02:37:15 INFO - Running pre-action listener: _resource_record_pre_action 02:37:15 INFO - Running main action method: read_buildbot_config 02:37:15 INFO - Using buildbot properties: 02:37:15 INFO - { 02:37:15 INFO - "project": "", 02:37:15 INFO - "product": "firefox", 02:37:15 INFO - "script_repo_revision": "production", 02:37:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:37:15 INFO - "repository": "", 02:37:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:37:15 INFO - "buildid": "20160419015854", 02:37:15 INFO - "pgo_build": "False", 02:37:15 INFO - "basedir": "/builds/slave/test", 02:37:15 INFO - "buildnumber": 2850, 02:37:15 INFO - "slavename": "talos-linux64-ix-020", 02:37:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:37:15 INFO - "platform": "ubuntu64_hw", 02:37:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:37:15 INFO - "branch": "fx-team", 02:37:15 INFO - "repo_path": "integration/fx-team", 02:37:15 INFO - "revision": "d4b74afcc60b937f25d54f365be46a8133980209", 02:37:15 INFO - "stage_platform": "linux64", 02:37:15 INFO - "builduid": "8bab387cbe944959afbb15c00274247e", 02:37:15 INFO - "slavebuilddir": "test" 02:37:15 INFO - } 02:37:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:37:15 INFO - Running post-action listener: _resource_record_post_action 02:37:15 INFO - ##### 02:37:15 INFO - ##### Running download-and-extract step. 02:37:15 INFO - ##### 02:37:15 INFO - Running pre-action listener: _resource_record_pre_action 02:37:15 INFO - Running main action method: download_and_extract 02:37:15 INFO - mkdir: /builds/slave/test/build/tests 02:37:15 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')]} 02:37:15 INFO - https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:37:19 INFO - Downloaded 1361 bytes. 02:37:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:37:19 INFO - Using the following test package requirements: 02:37:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:37:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:37:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:37:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'jsshell-linux-x86_64.zip'], 02:37:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:37:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:37:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:37:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:37:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:37:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:37:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:37:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:37: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')]} 02:37:19 INFO - https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:37:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:37:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:37:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:37:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:37:24 INFO - Downloaded 22209599 bytes. 02:37:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:37:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:37:25 INFO - Return code: 0 02:37:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:37:25 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')]} 02:37:25 INFO - https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:37:39 INFO - Downloaded 22209599 bytes. 02:37:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:37:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:37:41 INFO - Return code: 0 02:37:41 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')]} 02:37:41 INFO - https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:37:42 INFO - Downloaded 10845952 bytes. 02:37:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:37:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:37:42 INFO - Return code: 0 02:37: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')]} 02:37:42 INFO - https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:37:45 INFO - Downloaded 54449677 bytes. 02:37:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:37:45 INFO - mkdir: /builds/slave/test/properties 02:37:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:37:45 INFO - Writing to file /builds/slave/test/properties/build_url 02:37:45 INFO - Contents: 02:37:45 INFO - build_url:https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:37:46 INFO - Running post-action listener: _resource_record_post_action 02:37:46 INFO - Running post-action listener: set_extra_try_arguments 02:37:46 INFO - ##### 02:37:46 INFO - ##### Running populate-webroot step. 02:37:46 INFO - ##### 02:37:46 INFO - Running pre-action listener: _resource_record_pre_action 02:37:46 INFO - Running main action method: populate_webroot 02:37:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:37:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:37:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:37:46 INFO - '--tppagecycles', 02:37:46 INFO - '7'], 02:37:46 INFO - 'tests': ['tsvgm']}}, 02:37:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:37:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:37:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:37:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:37:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['damp', 'tps']}, 02:37:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'tests': ['damp', 'tps']}, 02:37:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['dromaeo_dom']}, 02:37:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:37:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['a11yr', 02:37:46 INFO - 'ts_paint', 02:37:46 INFO - 'tpaint', 02:37:46 INFO - 'sessionrestore', 02:37:46 INFO - 'sessionrestore_no_auto_restore', 02:37:46 INFO - 'tabpaint']}, 02:37:46 INFO - 'other-e10s': {'tests': ['a11yr', 02:37:46 INFO - 'ts_paint', 02:37:46 INFO - 'tpaint', 02:37:46 INFO - 'sessionrestore', 02:37:46 INFO - 'sessionrestore_no_auto_restore', 02:37:46 INFO - 'tabpaint']}, 02:37:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:37:46 INFO - 'ts_paint', 02:37:46 INFO - 'tpaint', 02:37:46 INFO - 'sessionrestore', 02:37:46 INFO - 'sessionrestore_no_auto_restore', 02:37:46 INFO - 'tabpaint']}, 02:37:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:37:46 INFO - 'ts_paint', 02:37:46 INFO - 'tpaint', 02:37:46 INFO - 'sessionrestore', 02:37:46 INFO - 'sessionrestore_no_auto_restore', 02:37:46 INFO - 'tabpaint']}, 02:37:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['a11yr', 02:37:46 INFO - 'ts_paint', 02:37:46 INFO - 'tpaint', 02:37:46 INFO - 'sessionrestore', 02:37:46 INFO - 'sessionrestore_no_auto_restore', 02:37:46 INFO - 'tabpaint']}, 02:37:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['a11yr', 02:37:46 INFO - 'ts_paint', 02:37:46 INFO - 'tpaint', 02:37:46 INFO - 'sessionrestore', 02:37:46 INFO - 'sessionrestore_no_auto_restore', 02:37:46 INFO - 'tabpaint']}, 02:37:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['tsvgx', 02:37:46 INFO - 'tsvgr_opacity', 02:37:46 INFO - 'tart', 02:37:46 INFO - 'tscrollx', 02:37:46 INFO - 'cart']}, 02:37:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:37:46 INFO - 'tsvgr_opacity', 02:37:46 INFO - 'tart', 02:37:46 INFO - 'tscrollx', 02:37:46 INFO - 'cart']}, 02:37:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'talos_options': ['--disable-e10s'], 02:37:46 INFO - 'tests': ['tp5o']}, 02:37:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'tests': ['tp5o']}, 02:37:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'talos_options': ['--disable-e10s', 02:37:46 INFO - '--xperf_path', 02:37:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:46 INFO - 'tests': ['tp5n']}, 02:37:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:37:46 INFO - 'talos_options': ['--xperf_path', 02:37:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:46 INFO - 'tests': ['tp5n']}}, 02:37:46 INFO - 'talos.zip': {'path': '', 02:37:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:37:46 INFO - Running post-action listener: _resource_record_post_action 02:37:46 INFO - ##### 02:37:46 INFO - ##### Running create-virtualenv step. 02:37:46 INFO - ##### 02:37:46 INFO - Running pre-action listener: _resource_record_pre_action 02:37:46 INFO - Running main action method: create_virtualenv 02:37:46 INFO - Creating virtualenv /builds/slave/test/build/venv 02:37:46 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 02:37:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:37:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:37:46 INFO - Using real prefix '/usr' 02:37:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:37:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:37:48 INFO - Installing pip.................done. 02:37:48 INFO - Return code: 0 02:37:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:37:48 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')]} 02:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:48 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')]} 02:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:48 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:37:48 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 02:37:48 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 02:37:48 INFO - Using env: {'DISPLAY': ':0', 02:37:48 INFO - 'HOME': '/home/cltbld', 02:37:48 INFO - 'LANG': 'en_US.UTF-8', 02:37:48 INFO - 'LANGUAGE': 'en_US:en', 02:37:48 INFO - 'LOGNAME': 'cltbld', 02:37:48 INFO - 'MAIL': '/var/mail/cltbld', 02:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:48 INFO - 'MOZ_NO_REMOTE': '1', 02:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:48 INFO - 'NO_EM_RESTART': '1', 02:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:48 INFO - 'PWD': '/builds/slave/test', 02:37:48 INFO - 'SHELL': '/bin/bash', 02:37:48 INFO - 'SHLVL': '1', 02:37:48 INFO - 'TERM': 'linux', 02:37:48 INFO - 'TMOUT': '86400', 02:37:48 INFO - 'USER': 'cltbld', 02:37:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:48 INFO - '_': '/tools/buildbot/bin/python'} 02:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:49 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 02:37:49 INFO - Cleaning up... 02:37:49 INFO - Return code: 0 02:37:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:37:49 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')]} 02:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:49 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')]} 02:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:49 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:37:49 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>=0.7.1'] in /builds/slave/test/build 02:37:49 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>=0.7.1 02:37:49 INFO - Using env: {'DISPLAY': ':0', 02:37:49 INFO - 'HOME': '/home/cltbld', 02:37:49 INFO - 'LANG': 'en_US.UTF-8', 02:37:49 INFO - 'LANGUAGE': 'en_US:en', 02:37:49 INFO - 'LOGNAME': 'cltbld', 02:37:49 INFO - 'MAIL': '/var/mail/cltbld', 02:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:49 INFO - 'MOZ_NO_REMOTE': '1', 02:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:49 INFO - 'NO_EM_RESTART': '1', 02:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:49 INFO - 'PWD': '/builds/slave/test', 02:37:49 INFO - 'SHELL': '/bin/bash', 02:37:49 INFO - 'SHLVL': '1', 02:37:49 INFO - 'TERM': 'linux', 02:37:49 INFO - 'TMOUT': '86400', 02:37:49 INFO - 'USER': 'cltbld', 02:37:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:49 INFO - '_': '/tools/buildbot/bin/python'} 02:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:49 INFO - Downloading/unpacking psutil>=0.7.1 02:37:49 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 02:37:49 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 02:37:49 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 02:37:49 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 02:37:49 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 02:37:49 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 02:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:37:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:51 INFO - Installing collected packages: psutil 02:37:51 INFO - Running setup.py install for psutil 02:37:51 INFO - building 'psutil._psutil_linux' extension 02:37:51 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 02:37:51 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 02:37:51 INFO - building 'psutil._psutil_posix' extension 02:37:51 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 02:37:51 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 02:37:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:51 INFO - Successfully installed psutil 02:37:51 INFO - Cleaning up... 02:37:51 INFO - Return code: 0 02:37:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:37:51 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')]} 02:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:51 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')]} 02:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:51 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:37:51 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.0.0'] in /builds/slave/test/build 02:37:51 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.0.0 02:37:51 INFO - Using env: {'DISPLAY': ':0', 02:37:51 INFO - 'HOME': '/home/cltbld', 02:37:51 INFO - 'LANG': 'en_US.UTF-8', 02:37:51 INFO - 'LANGUAGE': 'en_US:en', 02:37:51 INFO - 'LOGNAME': 'cltbld', 02:37:51 INFO - 'MAIL': '/var/mail/cltbld', 02:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:51 INFO - 'MOZ_NO_REMOTE': '1', 02:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:51 INFO - 'NO_EM_RESTART': '1', 02:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:51 INFO - 'PWD': '/builds/slave/test', 02:37:51 INFO - 'SHELL': '/bin/bash', 02:37:51 INFO - 'SHLVL': '1', 02:37:51 INFO - 'TERM': 'linux', 02:37:51 INFO - 'TMOUT': '86400', 02:37:51 INFO - 'USER': 'cltbld', 02:37:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:51 INFO - '_': '/tools/buildbot/bin/python'} 02:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:37:52 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 02:37:52 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 02:37:52 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 02:37:52 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 02:37:52 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 02:37:52 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 02:37:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:37:53 INFO - Installing collected packages: mozsystemmonitor 02:37:53 INFO - Running setup.py install for mozsystemmonitor 02:37:54 INFO - Successfully installed mozsystemmonitor 02:37:54 INFO - Cleaning up... 02:37:54 INFO - Return code: 0 02:37:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:37:54 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')]} 02:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:54 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')]} 02:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:54 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:37:54 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 02:37:54 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 02:37:54 INFO - Using env: {'DISPLAY': ':0', 02:37:54 INFO - 'HOME': '/home/cltbld', 02:37:54 INFO - 'LANG': 'en_US.UTF-8', 02:37:54 INFO - 'LANGUAGE': 'en_US:en', 02:37:54 INFO - 'LOGNAME': 'cltbld', 02:37:54 INFO - 'MAIL': '/var/mail/cltbld', 02:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:54 INFO - 'MOZ_NO_REMOTE': '1', 02:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:54 INFO - 'NO_EM_RESTART': '1', 02:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:54 INFO - 'PWD': '/builds/slave/test', 02:37:54 INFO - 'SHELL': '/bin/bash', 02:37:54 INFO - 'SHLVL': '1', 02:37:54 INFO - 'TERM': 'linux', 02:37:54 INFO - 'TMOUT': '86400', 02:37:54 INFO - 'USER': 'cltbld', 02:37:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:54 INFO - '_': '/tools/buildbot/bin/python'} 02:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:54 INFO - Downloading/unpacking blobuploader==1.2.4 02:37:54 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 02:37:54 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 02:37:54 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 02:37:54 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 02:37:54 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 02:37:54 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 02:37:56 INFO - Downloading blobuploader-1.2.4.tar.gz 02:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:37:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:37:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 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 02:37:56 INFO - Downloading docopt-0.6.1.tar.gz 02:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:37:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:37:56 INFO - Running setup.py install for blobuploader 02:37:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:37:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:37:57 INFO - Running setup.py install for requests 02:37:57 INFO - Running setup.py install for docopt 02:37:57 INFO - Successfully installed blobuploader requests docopt 02:37:57 INFO - Cleaning up... 02:37:57 INFO - Return code: 0 02:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:57 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')]} 02:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:57 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')]} 02:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:57 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:37:57 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 02:37:57 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 02:37:57 INFO - Using env: {'DISPLAY': ':0', 02:37:57 INFO - 'HOME': '/home/cltbld', 02:37:57 INFO - 'LANG': 'en_US.UTF-8', 02:37:57 INFO - 'LANGUAGE': 'en_US:en', 02:37:57 INFO - 'LOGNAME': 'cltbld', 02:37:57 INFO - 'MAIL': '/var/mail/cltbld', 02:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:57 INFO - 'MOZ_NO_REMOTE': '1', 02:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:57 INFO - 'NO_EM_RESTART': '1', 02:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:57 INFO - 'PWD': '/builds/slave/test', 02:37:57 INFO - 'SHELL': '/bin/bash', 02:37:57 INFO - 'SHLVL': '1', 02:37:57 INFO - 'TERM': 'linux', 02:37:57 INFO - 'TMOUT': '86400', 02:37:57 INFO - 'USER': 'cltbld', 02:37:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:57 INFO - '_': '/tools/buildbot/bin/python'} 02:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:57 INFO - Running setup.py (path:/tmp/pip-_jaohR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:57 INFO - Running setup.py (path:/tmp/pip-ptcqOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:57 INFO - Running setup.py (path:/tmp/pip-oxcW5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:57 INFO - Running setup.py (path:/tmp/pip-0bU8mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:58 INFO - Running setup.py (path:/tmp/pip-P0IcIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:58 INFO - Running setup.py (path:/tmp/pip-GpYkpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:58 INFO - Running setup.py (path:/tmp/pip-EBpfGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:58 INFO - Running setup.py (path:/tmp/pip-JYwne6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:58 INFO - Running setup.py (path:/tmp/pip-DESQkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:58 INFO - Running setup.py (path:/tmp/pip-wXy8t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:58 INFO - Running setup.py (path:/tmp/pip-yUFEr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:58 INFO - Running setup.py (path:/tmp/pip-EtEExb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:58 INFO - Running setup.py (path:/tmp/pip-ONFuo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:58 INFO - Running setup.py (path:/tmp/pip-qIIyMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:58 INFO - Running setup.py (path:/tmp/pip-LqnwiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:58 INFO - Running setup.py (path:/tmp/pip-JAqZQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:58 INFO - Running setup.py (path:/tmp/pip-7f5JrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:37:58 INFO - Running setup.py install for manifestparser 02:37:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Running setup.py install for mozcrash 02:37:59 INFO - Running setup.py install for mozdebug 02:37:59 INFO - Running setup.py install for mozdevice 02:37:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Running setup.py install for mozfile 02:37:59 INFO - Running setup.py install for mozhttpd 02:37:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Running setup.py install for mozinfo 02:37:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Running setup.py install for mozInstall 02:37:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:37:59 INFO - Running setup.py install for mozleak 02:37:59 INFO - Running setup.py install for mozlog 02:37:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Running setup.py install for moznetwork 02:38:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Running setup.py install for mozprocess 02:38:00 INFO - Running setup.py install for mozprofile 02:38:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Running setup.py install for mozrunner 02:38:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Running setup.py install for mozscreenshot 02:38:00 INFO - Running setup.py install for moztest 02:38:00 INFO - Running setup.py install for mozversion 02:38:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:00 INFO - Cleaning up... 02:38:00 INFO - Return code: 0 02:38:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:00 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')]} 02:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:00 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')]} 02:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:00 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:38:00 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 02:38:00 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 02:38:00 INFO - Using env: {'DISPLAY': ':0', 02:38:00 INFO - 'HOME': '/home/cltbld', 02:38:00 INFO - 'LANG': 'en_US.UTF-8', 02:38:00 INFO - 'LANGUAGE': 'en_US:en', 02:38:00 INFO - 'LOGNAME': 'cltbld', 02:38:00 INFO - 'MAIL': '/var/mail/cltbld', 02:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:00 INFO - 'MOZ_NO_REMOTE': '1', 02:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:00 INFO - 'NO_EM_RESTART': '1', 02:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:00 INFO - 'PWD': '/builds/slave/test', 02:38:00 INFO - 'SHELL': '/bin/bash', 02:38:00 INFO - 'SHLVL': '1', 02:38:00 INFO - 'TERM': 'linux', 02:38:00 INFO - 'TMOUT': '86400', 02:38:00 INFO - 'USER': 'cltbld', 02:38:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:00 INFO - '_': '/tools/buildbot/bin/python'} 02:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:00 INFO - Running setup.py (path:/tmp/pip-ZpIZx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:01 INFO - Running setup.py (path:/tmp/pip-N65PW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:01 INFO - Running setup.py (path:/tmp/pip-WRyQe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:01 INFO - Running setup.py (path:/tmp/pip-6SOii9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:01 INFO - Running setup.py (path:/tmp/pip-4n0A_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:01 INFO - Running setup.py (path:/tmp/pip-0EbfeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:01 INFO - Running setup.py (path:/tmp/pip-YkjgO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:01 INFO - Running setup.py (path:/tmp/pip-vN0rYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:01 INFO - Running setup.py (path:/tmp/pip-8RkUsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:01 INFO - Running setup.py (path:/tmp/pip-Ib9HjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:01 INFO - Running setup.py (path:/tmp/pip-zBZ7Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:01 INFO - Running setup.py (path:/tmp/pip-y8734d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:01 INFO - Running setup.py (path:/tmp/pip-b3Wm4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:01 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)) 02:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:01 INFO - Running setup.py (path:/tmp/pip-_Ch1h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:02 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)) 02:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:02 INFO - Running setup.py (path:/tmp/pip-nJfht7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:02 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)) 02:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:02 INFO - Running setup.py (path:/tmp/pip-YZplDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:02 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)) 02:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:02 INFO - Running setup.py (path:/tmp/pip-nZCAv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:02 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)) 02:38:02 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)) 02:38:02 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)) 02:38:02 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)) 02:38:02 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)) 02:38:02 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)) 02:38:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:02 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 02:38:02 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 02:38:02 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 02:38:02 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 02:38:02 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 02:38:02 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 02:38:04 INFO - Downloading blessings-1.6.tar.gz 02:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:38:04 INFO - Installing collected packages: blessings 02:38:04 INFO - Running setup.py install for blessings 02:38:04 INFO - Successfully installed blessings 02:38:04 INFO - Cleaning up... 02:38:04 INFO - Return code: 0 02:38:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:04 INFO - Reading from file tmpfile_stdout 02:38:04 INFO - Current package versions: 02:38:04 INFO - argparse == 1.2.1 02:38:04 INFO - blessings == 1.6 02:38:04 INFO - blobuploader == 1.2.4 02:38:04 INFO - docopt == 0.6.1 02:38:04 INFO - manifestparser == 1.1 02:38:04 INFO - mozInstall == 1.12 02:38:04 INFO - mozcrash == 0.17 02:38:04 INFO - mozdebug == 0.1 02:38:04 INFO - mozdevice == 0.48 02:38:04 INFO - mozfile == 1.2 02:38:04 INFO - mozhttpd == 0.7 02:38:04 INFO - mozinfo == 0.9 02:38:04 INFO - mozleak == 0.1 02:38:04 INFO - mozlog == 3.1 02:38:04 INFO - moznetwork == 0.27 02:38:04 INFO - mozprocess == 0.22 02:38:04 INFO - mozprofile == 0.28 02:38:04 INFO - mozrunner == 6.11 02:38:04 INFO - mozscreenshot == 0.1 02:38:04 INFO - mozsystemmonitor == 0.0 02:38:04 INFO - moztest == 0.7 02:38:04 INFO - mozversion == 1.4 02:38:04 INFO - psutil == 3.1.1 02:38:04 INFO - requests == 1.2.3 02:38:04 INFO - wsgiref == 0.1.2 02:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:04 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')]} 02:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:04 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')]} 02:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:04 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:38:04 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 02:38:04 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 02:38:04 INFO - Using env: {'DISPLAY': ':0', 02:38:04 INFO - 'HOME': '/home/cltbld', 02:38:04 INFO - 'LANG': 'en_US.UTF-8', 02:38:04 INFO - 'LANGUAGE': 'en_US:en', 02:38:04 INFO - 'LOGNAME': 'cltbld', 02:38:04 INFO - 'MAIL': '/var/mail/cltbld', 02:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:04 INFO - 'MOZ_NO_REMOTE': '1', 02:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:04 INFO - 'NO_EM_RESTART': '1', 02:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:04 INFO - 'PWD': '/builds/slave/test', 02:38:04 INFO - 'SHELL': '/bin/bash', 02:38:04 INFO - 'SHLVL': '1', 02:38:04 INFO - 'TERM': 'linux', 02:38:04 INFO - 'TMOUT': '86400', 02:38:04 INFO - 'USER': 'cltbld', 02:38:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:04 INFO - '_': '/tools/buildbot/bin/python'} 02:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 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)) 02:38:04 INFO - Cleaning up... 02:38:04 INFO - Return code: 0 02:38:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38:04 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')]} 02:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:04 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')]} 02:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:04 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:38:04 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 02:38:04 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 02:38:04 INFO - Using env: {'DISPLAY': ':0', 02:38:04 INFO - 'HOME': '/home/cltbld', 02:38:04 INFO - 'LANG': 'en_US.UTF-8', 02:38:04 INFO - 'LANGUAGE': 'en_US:en', 02:38:04 INFO - 'LOGNAME': 'cltbld', 02:38:04 INFO - 'MAIL': '/var/mail/cltbld', 02:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:04 INFO - 'MOZ_NO_REMOTE': '1', 02:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:04 INFO - 'NO_EM_RESTART': '1', 02:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:04 INFO - 'PWD': '/builds/slave/test', 02:38:04 INFO - 'SHELL': '/bin/bash', 02:38:04 INFO - 'SHLVL': '1', 02:38:04 INFO - 'TERM': 'linux', 02:38:04 INFO - 'TMOUT': '86400', 02:38:04 INFO - 'USER': 'cltbld', 02:38:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:04 INFO - '_': '/tools/buildbot/bin/python'} 02:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:04 INFO - Downloading/unpacking jsonschema 02:38:04 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 02:38:04 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 02:38:04 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 02:38:04 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 02:38:04 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 02:38:04 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 02:38:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:06 INFO - Downloading/unpacking functools32 (from jsonschema) 02:38:06 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 02:38:06 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 02:38:06 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 02:38:06 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 02:38:06 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 02:38:06 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 02:38:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:07 INFO - warning: no files found matching '*.txt' 02:38:07 INFO - no previously-included directories found matching 'build' 02:38:07 INFO - no previously-included directories found matching 'dist' 02:38:07 INFO - no previously-included directories found matching '.git*' 02:38:07 INFO - Installing collected packages: jsonschema, functools32 02:38:07 INFO - Running setup.py install for functools32 02:38:07 INFO - warning: no files found matching '*.txt' 02:38:07 INFO - no previously-included directories found matching 'build' 02:38:07 INFO - no previously-included directories found matching 'dist' 02:38:07 INFO - no previously-included directories found matching '.git*' 02:38:07 INFO - Successfully installed jsonschema functools32 02:38:07 INFO - Cleaning up... 02:38:07 INFO - Return code: 0 02:38:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:38:07 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')]} 02:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:07 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')]} 02:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:07 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 0x7fab42691f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24af5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', '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 02:38:07 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 02:38:07 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 02:38:07 INFO - Using env: {'DISPLAY': ':0', 02:38:07 INFO - 'HOME': '/home/cltbld', 02:38:07 INFO - 'LANG': 'en_US.UTF-8', 02:38:07 INFO - 'LANGUAGE': 'en_US:en', 02:38:07 INFO - 'LOGNAME': 'cltbld', 02:38:07 INFO - 'MAIL': '/var/mail/cltbld', 02:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:07 INFO - 'MOZ_NO_REMOTE': '1', 02:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:07 INFO - 'NO_EM_RESTART': '1', 02:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:07 INFO - 'PWD': '/builds/slave/test', 02:38:07 INFO - 'SHELL': '/bin/bash', 02:38:07 INFO - 'SHLVL': '1', 02:38:07 INFO - 'TERM': 'linux', 02:38:07 INFO - 'TMOUT': '86400', 02:38:07 INFO - 'USER': 'cltbld', 02:38:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:07 INFO - '_': '/tools/buildbot/bin/python'} 02:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:07 INFO - Downloading/unpacking flake8 02:38:07 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 02:38:07 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 02:38:07 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 02:38:07 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 02:38:07 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 02:38:07 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 02:38:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:38:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:38:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:09 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 02:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:10 INFO - no previously-included directories found matching 'docs/_build' 02:38:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:38:10 INFO - Running setup.py install for pep8 02:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:38:10 INFO - no previously-included directories found matching 'docs/_build' 02:38:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:38:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:38:10 INFO - Cleaning up... 02:38:10 INFO - Return code: 0 02:38:10 INFO - Running post-action listener: _resource_record_post_action 02:38:10 INFO - Running post-action listener: _start_resource_monitoring 02:38:10 INFO - Starting resource monitoring. 02:38:10 INFO - ##### 02:38:10 INFO - ##### Running install step. 02:38:10 INFO - ##### 02:38:10 INFO - Running pre-action listener: _resource_record_pre_action 02:38:10 INFO - Running main action method: install 02:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:10 INFO - Reading from file tmpfile_stdout 02:38:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:10 INFO - Reading from file tmpfile_stdout 02:38:10 INFO - Output received: 02:38:10 INFO - Usage: mozinstall [options] installer 02:38:10 INFO - Options: 02:38:10 INFO - -h, --help show this help message and exit 02:38:10 INFO - -d DEST, --destination=DEST 02:38:10 INFO - Directory to install application into. [default: 02:38:10 INFO - "/builds/slave/test"] 02:38:10 INFO - --app=APP Application being installed. [default: firefox] 02:38:10 INFO - mkdir: /builds/slave/test/build/application 02:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:38:26 INFO - Reading from file tmpfile_stdout 02:38:26 INFO - Output received: 02:38:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:38:26 INFO - Running post-action listener: _resource_record_post_action 02:38:26 INFO - ##### 02:38:26 INFO - ##### Running run-tests step. 02:38:26 INFO - ##### 02:38:26 INFO - Running pre-action listener: _resource_record_pre_action 02:38:26 INFO - Running main action method: run_tests 02:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:38:26 INFO - Python 2.7.3 02:38:26 INFO - Return code: 0 02:38:26 INFO - grabbing minidump binary from tooltool 02:38: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')]} 02:38:26 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253e410>, '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 0x253f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:38:26 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 02:38:26 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 02:38:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:38:26 INFO - Return code: 0 02:38:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:38:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:38:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:38:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:38:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:38:27 INFO - Return code: 0 02:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 02:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 02:38:27 INFO - Using env: {'DISPLAY': ':0', 02:38:27 INFO - 'HOME': '/home/cltbld', 02:38:27 INFO - 'LANG': 'en_US.UTF-8', 02:38:27 INFO - 'LANGUAGE': 'en_US:en', 02:38:27 INFO - 'LOGNAME': 'cltbld', 02:38:27 INFO - 'MAIL': '/var/mail/cltbld', 02:38:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:27 INFO - 'MOZ_NO_REMOTE': '1', 02:38:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:27 INFO - 'NO_EM_RESTART': '1', 02:38:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:27 INFO - 'PWD': '/builds/slave/test', 02:38:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:27 INFO - 'SHELL': '/bin/bash', 02:38:27 INFO - 'SHLVL': '1', 02:38:27 INFO - 'TERM': 'linux', 02:38:27 INFO - 'TMOUT': '86400', 02:38:27 INFO - 'USER': 'cltbld', 02:38:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630', 02:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:27 INFO - '_': '/tools/buildbot/bin/python'} 02:38:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 02:38:28 INFO - mozversion application_buildid: 20160419015854 02:38:28 INFO - mozversion application_changeset: d4b74afcc60b937f25d54f365be46a8133980209 02:38:28 INFO - mozversion application_display_name: Nightly 02:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:38:28 INFO - mozversion application_name: Firefox 02:38:28 INFO - mozversion application_remotingname: firefox 02:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:38:28 INFO - mozversion application_vendor: Mozilla 02:38:28 INFO - mozversion application_version: 48.0a1 02:38:28 INFO - mozversion platform_buildid: 20160419015854 02:38:28 INFO - mozversion platform_changeset: d4b74afcc60b937f25d54f365be46a8133980209 02:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:38:28 INFO - mozversion platform_version: 48.0a1 02:38:28 INFO - using testdate: 1461058708 02:38:28 INFO - actual date: 1461058708 02:38:28 INFO - starting webserver on 'localhost:34800' 02:38:28 INFO - SUITE-START | Running 2 tests 02:38:28 INFO - TEST-START | dromaeo_css 02:38:28 INFO - operating with platform_type : linux_ 02:38:28 INFO - Initialising browser for dromaeo_css test... 02:38:28 INFO - TEST-INFO | started process 21585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKeaQZ/profile http://localhost:34800/getInfo.html) 02:38:33 INFO - PROCESS | 21585 | __metrics Screen width/height:1600/1200 02:38:33 INFO - PROCESS | 21585 | colorDepth:24 02:38:33 INFO - PROCESS | 21585 | Browser inner width/height: 1024/697 02:38:33 INFO - PROCESS | 21585 | __metrics 02:38:34 ERROR - PROCESS | 21585 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:38:34 INFO - TEST-INFO | 21585: exit 0 02:38:34 INFO - Browser initialized. 02:38:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:34 INFO - TEST-INFO | started process 21672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKeaQZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:46 INFO - PROCESS | 21672 | RSS: Main: 154824704 02:38:46 INFO - PROCESS | 21672 | 02:39:38 INFO - PROCESS | 21672 | 1461058778340 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] 02:41:49 INFO - PROCESS | 21672 | Cycle 1(1): loaded http://localhost:34800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34800/tests/dromaeo/cssquery-ext.html) 02:41:50 INFO - PROCESS | 21672 | RSS: Main: 226066432 02:41:50 INFO - PROCESS | 21672 | 02:44:53 INFO - PROCESS | 21672 | Cycle 1(1): loaded http://localhost:34800/tests/dromaeo/cssquery-ext.html (next: http://localhost:34800/tests/dromaeo/cssquery-jquery.html) 02:44:54 INFO - PROCESS | 21672 | RSS: Main: 233259008 02:44:54 INFO - PROCESS | 21672 | 02:47:56 INFO - PROCESS | 21672 | Cycle 1(1): loaded http://localhost:34800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34800/tests/dromaeo/cssquery-mootools.html) 02:47:56 INFO - PROCESS | 21672 | RSS: Main: 234053632 02:47:56 INFO - PROCESS | 21672 | 02:50:58 INFO - PROCESS | 21672 | Cycle 1(1): loaded http://localhost:34800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34800/tests/dromaeo/cssquery-prototype.html) 02:50:59 INFO - PROCESS | 21672 | RSS: Main: 237092864 02:50:59 INFO - PROCESS | 21672 | 02:54:02 INFO - PROCESS | 21672 | Cycle 1(1): loaded http://localhost:34800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34800/tests/dromaeo/cssquery-yui.html) 02:54:03 INFO - PROCESS | 21672 | RSS: Main: 214945792 02:54:03 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | Cycle 1(1): loaded http://localhost:34800/tests/dromaeo/cssquery-yui.html (next: http://localhost:34800/tests/dromaeo/cssquery-dojo.html) 02:57:05 INFO - PROCESS | 21672 | RSS: Main: 292913152 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | __start_tp_report 02:57:05 INFO - PROCESS | 21672 | _x_x_mozilla_page_load 02:57:05 INFO - PROCESS | 21672 | _x_x_mozilla_page_load_details 02:57:05 INFO - PROCESS | 21672 | |i|pagename|runs| 02:57:05 INFO - PROCESS | 21672 | |0;dojo.html;2591.7278685737997;2658.4417272372802;2669.639598654181;2682.6646669166353;2704.7700945419638;4502.572255635718;4549.72701637902;4554.726716397018;4557.453105627325;4561.429821272337;4599.793009314581;4609.884752881179;4680.110778952006;4690.24956007039;4697.060587882429;4177.373393990911;4214.325707886731;4237.0254841386495;4288.914221715564;4361.869143925672;4335;4366.1922544329245;4379.737215767048;4396.428464299653;4405.449318835145;4154.563770804052;4201.810918508644;4216.47294088239;4257.489101307863;4303.526612072686;4213.220554197453;4243.045314804144;4244.129953359554;4248.936265955982;4273.18809426208;4210.494740631113;4246.065865509614;4250.256205164084;4260.9147817043795;4295.6778241632;4386.780660966971;4492.640588752892;4553.817847286105;4556.498785133633;4564.885877853047;4892.608591312686;4916.803327866881;4935;4936.777844996948;4979.601631869442;4916;4945.455999840015;4946.233333833262;4966.404031516205;4997.325361076281;4511.458624964959;4605.769711514411;4645.070985802853;4678.508756580578;4690.835820746258;5030.84907452777;5038.445770965191;5049.444561098277;5057.013882292991;5057.544820966057;4856.295837103671;4860.708357498562;4865.537773911473;4866.853994380103;4912.38595175603;4820;4940.777665005084;4970.453250142481;5003.549680528697;5025.748712564357;4780.163471392492;4804.495527969513;4809.014152098881;4833.685810422311;4849.951500485021;4757.666963312535;4796.232602783538;4799.3041009053495;4804.447488538863;4850.927236091461;4124.237016152021;4133.028738246509;4164.3961625564125;4200.5169405518145;4205.222033923734;3616.1863580694135;3638.272345530904;3639.526861507987;3665.2119794244363;3681.4109742441083;4197.685173611931;4224.408582798411;4226.556211597799;4233.7671428071135;4263.936040959388;4927.605791536668;4979.601631869442;4983.900321993612;5030.723310217973;5032.295478632995;4222.641075508616;4236.724612900151;4236.894077648022;4240.024794297329;4285.592868677533;4339.305711086211;4411.867643970686;4412.977935110304;4414.735115892992;4444.755538445352;4719.480857105647;4725;4725.881852953635;4763.833265835679;4768.737719425465;4943.480934501826;4982.003599280086;4987.476314986874;4988.72562009093;5028.472010438852;4567.634589232787;4664.230401983635;4684.203685373426;4692.812287508598;4743.478217396015;4929.162042452864;4929.580985616263;4940.431850337257;4949.232868905326;4997.9750101249265;4984.651074424755;4996.175631020987;5000.874978125576;5008.373953255843;5068.619853510928;4656.906861862676;4738.715677059387;4788.904221915612;4843.709377437365;4918.680285781413;4765.166095933268;4772.141014617263;4781.976090119527;4821.783019764189;4823.1800593899825;4709.576138147583;4709.8116075357975;4723.456802467623;4754.21555443348;4762.023785123972;4658.767061646972;4791.760411979457;4797.2564252540915;4873.025394921101;4885.438174609965;4685.4845966944295;4699.224627936489;4709.9529004710885;4716.410448693913;4767.308740232577 02:57:05 INFO - PROCESS | 21672 | |1;ext.html;581.4650521520201;593.9605690042425;612.3937302070951;617.7436363908977;621.2141640824356;25966.22101336958;26431.471370572577;26437.999999999975;26477.470450590976;26488.33779155522;35097.82451087747;35276.29447411057;35902;36036.459453108226;36080;7616.352610028154;7772.7668169954995;7791.376689864797;7792.80517987052;7795.259450352208;7341.853162936738;7641.044869391326;7780.066392032935;7798.181190974951;9759.75600609987;9776.413415195111;9886.209103271722;9889.307748457612;9894.604215831358;9894.851577226347;9615.855762163574;9736.561854716483;9745.805083898282;9747.805043899083;9749.707508774749;9643.180329671986;9762;9765.511724413751;9768.07203315684;9772.609095636166;34924.82537587321;35174.824125879466;35235.29529409397;35235.647643523494;38583.42124868129;3047.207725991236;3065.984670076635;3083.2137804859617;3348.96651033489;3373.1061268763797;28565.71434285672;28733.56899646507;28907.421851562853;29168.270793230127;29919.5512067317;3124.109628755794;3128.0459459864733;3167.33485967947;3205;3244.6755324467363;174418;175042;175377;175461;176244;54315.72842135764;54868;54877.45122548803;54901;54905.176422353696;56702.43297566971;57066.7146664264;57471.425285746605;57589.71205143948;57596.39228861681;15286.617834554225;15497.767533487007;15511.689766204612;15517.45688900883;15524.844751552566;10135;10213.387196768217;10227.539760710786;10229.335093218917;10323.174146068297;16172.595685107966;17161.31354745796;17400.73898891518;17407.303707851544;17426.738598921027;5835.737391817378;6007.879842403127;6071.332153463116;6084.239470066242;6162.106494558264;909.6543313540944;961.524075505576;964.6720115160879;1017.0947856407803;1049.228816819637;28097.735601897555;28251.57622635662;28489.43021139607;28496.572551411744;28743.712562874523;961.3414810854587;981.6367943860818;1025.1593693171528;1047.104725459721;1077.0683358894657;14368.928155359155;15059.397624095132;15098.39606415753;15347.846521534864;15387.153706546247;303918;307606;309357;309372;310224;49306.50693493091;50468;50543.494565054614;50556;50645.49354506481;1060.2472244706346;1158.9942050289862;1184.1651635596884;1237.5359240285072;1274.8278982337451;26964.595531066658;27579.72420275852;28180.295492612848;28409.57385639176;28525.28686782847;40203;40340.79829600833;40687.59312406838;40919.590804091575;40945.385819213334;205789;207393;207592;207694;208796;31891.840540797148;32956.50565241571;36455;37780.62219377771;37804.43293350547;39528.60471395249;40394.59605403908;40888.182236354514;40968;41170.38244426276;34427.65572344245;34530.30939381148;34706.479402809484;35043;35344.64655353517;34573.30853382969;34786.13034674052;35061.64938350686;35239.64760352466;35488;35185.296294074484;35427;35739;37636.435453468766;39257.2148557033;29330.56004159982;31021.68978310188;31411.528827067155;31461;31704.524432133076;24405.240036096806;24459.633105503788;24851.87574062118;26334.60498092492;27916.860415697793 02:57:05 INFO - PROCESS | 21672 | |2;jquery.html;381.9369803982342;385.91509867829075;386.4454507781336;396.5518963571164;401.793076565569;12933.41799619017;13552.796708049362;15660.921695391522;16731.58171045723;16749.078800665942;15443.382264709426;15630.062196268233;15714.685706285867;15735.134567598778;16280.51158465245;5029.245613158028;5159.174532074869;5196.610254230929;5196.844094677147;5222.895542089156;5013.699178049329;5206.088934436478;5214.791408343662;5227.4511176326505;5233.4243233244315;5126.384833819928;5190.506901844319;5190.974045129769;5194.896102077956;5195.6622819516615;4994.275830004647;5094.923576146361;5096.974515127437;5150.510701483372;5150.948490515103;4578.381918441001;4583.2666773316105;4589.518100599423;4594.287885377772;4607.907841843178;11798.233114847508;12426.316552589604;12456.065795065315;12459.06557008219;12480.937595312056;1784.3041213926579;1788.8121747216485;1823.188681036939;1853.3050106210171;1990.2337600024096;9010;9047.909520904772;9119.088091190893;9456.243500519942;9626.326157169002;1693.6443346897167;1815.3464752689022;1916.8945707986056;1984.1369004483097;1987.9701804472945;64558.031629525125;66049.3395066048;68116.6594167031;68695.65652171757;69590;9883.308168428284;10007.199424046059;10137.391756494633;10193.796124077626;10257.640982565574;12350.258984460781;12887.871121288666;14029.298535073205;14315.856841431661;14357.066790658573;6511.772087976898;6780.38976492118;6905.827354316082;7340.412766978736;7441.293077157661;6851.38337549613;6880.862382752417;7046.365827075485;7134.108236470442;7147.714091436388;4275.3800698898485;4276.444062271885;4326.3510473428605;4356.847510337123;4420.160169567772;1779.181576474836;1843.9446816595523;1848.223746026672;1857.3499275253553;1875.37175046361;879.1077056787366;885.6059053721033;954.5036580977853;969.8011907558933;994.080475560104;15337.463188788339;16842.589260725486;16852;17084.572885677957;17174.39889603858;876.5836227791875;880.3265501891059;886.7162507997508;901.4095767272447;951.4243882451156;9131.680391186277;9233.307501937381;9387.953060234655;9432.717018489457;9642.084002019797;304854;312953;355473;374281;377137;79361.60319198367;82525.17474825295;84477.57761211155;84818.57590712131;86703.56648216845;950.5579905344048;963.1524258652341;978.3445091788519;993.9055789699967;996.1482932092956;14952.32714527827;14995.550133495577;15313.46402875894;15362.155081470626;15553.144577048372;34355.484667729506;35435.291294173454;35773.46339804957;35937.101572460895;36477.45283820692;46267.3059904095;48528;50907.2363914549;51175.744121280644;51241.7437912808;7209.279072092749;7226.963865180641;7418.591977441292;7422.814429639302;7582.658780354787;9864.5560949756;10776.892231077589;11050.723731906766;11098.944505277423;11099.389533575408;9579.185769209695;9670.068858229797;9727.65953191635;9806.52902064696;9977.251706121924;9757.609695612096;9793.75515612087;9809.411435313905;9884.901150988399;9898.307118501636;9863.114762270332;9886.653967111117;10115.39307641544;10178.541965611714;10262;6906.8618627628175;6916.723331066701;7092.184398794205;7100.112485939258;7109.75115870942;8530.786730331543;9809.558569864515;9953.552090156105;10021.949890250502;10079.69760907174 02:57:05 INFO - PROCESS | 21672 | |3;mootools.html;1288.27212624867;1402.340899777105;1458.0231245065804;1517.9165145916977;1752.1939907642475;6564.770233041839;7576.659050342734;7742.651580678869;7813.882791758128;7821.2178782121755;7439.442041846856;7752.108507521637;7754.689812407511;7755.573443460621;7757.689692412297;1954.3843689237915;2202.735671719396;2239.9216027439;2268.308166009375;2280.2019293247395;2286.4626812699084;2310.722713274409;2312.3063081075693;2313.90744370225;2315.5947709150914;2214.1475531920164;2263.581237471073;2267.761885002076;2268.4782500025003;2268.6029944759684;1915.205189846212;2126.1282874021654;2187;2195.989844671453;2198.7361516618107;2170.858894171874;2189.2665956904457;2193.5503221839485;2213.8893055347166;2241.9775802242093;7713.305802477804;7718.498297610693;7730.961345193295;7792.844143117106;7800.960995194988;4662.8134874604975;4818.7831547580445;4825.10735513931;4826.517348265181;4853.199222128344;2931.3404483991144;2953.8375389353578;2978.7616990640695;3033.5601337806115;3050.66442691306;913.9086091390874;1657.0968821992044;1702.5998890260778;1706.7525208844647;1709.7777288952357;10048.94975525125;10258.846117308247;10260.69217923456;10265.692029239135;10303.433311167882;4029.81865816039;4071.246819338432;4168.3955826405;4181.163767246502;4194.664426845845;8175.7138500152205;8179.345652347798;8213.835723285501;8215.712450064219;8439.451435656663;4122.855700050543;4732.1718699227495;4749.857504274877;4754.358161648202;4758.333833263346;4229.661627069827;4313.741175529478;4316.69783115179;4340.804663790137;4342.761148136819;3517.683408493248;3520.507129001942;3593.6765691087403;3629.709623230135;3661.707063434919;1080.9351438913534;1088.4122573810055;1096.1504833753904;1112.8275117356823;1115.6653004098737;805.8468890910708;837.4975014991079;838.7861095420628;842.8735689646602;854.9016863060704;5151.6136289778415;5213.0206315621845;5301.920471192935;5303.575713942875;5464.316960379952;422.391755871544;432.2263148963383;435.1536261970437;439.545070851667;442.2415557319213;3592.497050412944;3650.8539658413897;3652.342578335925;3694.261147770457;3716.888493345204;9362.25101991839;9776.951115244377;9813.11681948628;9845.852312215322;9866.80266394668;9616.08647178517;9714.951425242829;9719.805603887882;9739;9748.366356186825;7332.96333518329;7434.814129646802;7436.702531898663;7445.702171913171;7501.474896757284;5068.189089745623;5085.847424577269;5258.263843061898;5289.788408463773;5316.122839731401;8949.59726812308;8983.371164018456;8992.55037248148;9058.728238152866;9088.227500662519;8703.216710496086;9041.18629323364;9200.815983680423;9231.538423078684;9239.907600923905;5834.329052159056;6030.216071910623;6052.727627256872;6489.448396886318;6533.314002029909;6550.901736473861;7124.180719217149;7348.96325518369;7354.264573542603;7362.7423040193335;6560.770373036921;6572.967135164294;6695.765648202484;6711.63086030273;6857.5199736018;6640.601563906181;6659.2008958925235;6659.733610655519;6665.600063996176;6698.229703583956;6044.274687037584;6101.60339577926;6103.481204097701;6109.816705498843;6154.753809847735;4363.890902727458;4469.575390337913;4612.146752850734;4617.9307310389695;4678.883027924329;4553.749543775124;4619.445666520039;4661.137689527448;4695.154872123051;4721.315409265706 02:57:05 INFO - PROCESS | 21672 | |4;prototype.html;312.23035218187164;312.31914426550117;313.45458901511375;319.7170504103869;319.83848156680904;5056.469070747569;5124.615653825964;5127.1027570175165;5136.614753893459;5141.871453213672;5060.41805192403;5060.645754797166;5061.797528098881;5065.240213967907;5071.1886098224195;3763.6800871925852;3826.65560099591;3990.5610382857863;3992.281389349916;4013.6989725770536;3948.2498325318243;3975.602439756016;3982.402639604068;3986.7607943523335;3990.900227494307;3735.234276973214;3959.6238357356006;3962.2273656636967;3965.2466031453932;3967.5238971323483;3806.276807406584;3972.080520817197;3978.6220309070736;3979.701522385804;3982.5021872265966;3500.2999400119825;3502.8423720932365;3509.0700964244497;3512.4731290306404;3525.1539630488755;4871.293662418965;4873.951260487421;4890.779914903802;4893.168161412568;4901.264810278487;4240.893977650583;4500.952066809594;4505.36924830524;4530;4596.080783843211;5327.227552004976;5327.493888080626;5337.759800808973;5338.944506365038;5344.9732751336;3772.3775577029755;3774.358359078963;3775.924481510382;3783.2622638585485;3793.165503589206;5534.252875861747;5539.918243935429;5589.720513974285;5593.608447408724;5607.495325420732;3810.123671555558;3819.7708137511836;3843.1929294848396;3847.249786291646;3852.8651497197466;3843.557990831034;3878.7672739635714;3885.3783394657285;3895.376739721631;3907.374820028782;4196.370544418301;4442.42248507692;4473.329000649928;4484.1031793641405;4484.372187893698;5330.466953304638;5336.012837624974;5339.733013349317;5348.545373643206;5358.571314294925;1327.9867201328057;1340.5509154433373;1350.5616518407865;1356.409961666678;1361.3737680667004;844.5270648436895;883.3330835219368;900.3652425040331;910.6721580231111;922.6171138977384;4646.395968524138;4675.275332323496;4682.906341873144;4686.929696054562;4691.319758634979;5496.378568322275;5497.835064948058;5502.449755024546;5505.339359276913;5513.58648101394;4491.348754430589;4675.696079754873;4683.718976861399;4699;4715.85852424421;2962.5852380666724;2978.627671541057;2984.4777163996214;2991.8504074796174;2997.1158508240123;5277.1002439121885;5277.815276465305;5280.6303558750515;5281.260623512711;5281.762320695578;5513.531349835229;5711.742971566289;5721.8569535761935;5732.856678582985;5735.483806457355;5244.108501554745;5253.1857562077175;5253.369595648546;5255.500727430965;5258.737063146904;5424.783008679608;5559.694216818114;5573.581981351496;5583.190437386637;5587.245721827664;5425.593080518898;5437.34751829783;5451.754671039734;5473.917891231555;5477.917831232455;5185.559227465556;5212.921806172834;5226;5235.554977826928;5240.292560504436;3773.358529050013;3836.5204349456317;3862.748921320105;3868.864589739346;3877.457155998106;5530.723463826712;5541.612087153861;5549.392894618531;5553.9444605555045;5555.611107222456;5345.1714984177515;5368.516833485005;5374.247605335335;5380.51575358204;5404;5278.81524146653;5310.548603368602;5373.892522149457;5374.247605335178;5374.865628359323;5004.324416203766;5239.711815850165;5260.9736951315;5270.920936185884;5279.577633789211;5184;5336.759845807026;5420.268263784496;5421.620486565903;5425;5271;5283.101872681576;5286.444923283;5298.3906850712665;5299.205119231991 02:57:05 INFO - PROCESS | 21672 | |5;yui.html;622.0948519903541;679.3953381490472;773.3928865840314;777.1956025513595;794.3724457678435;12832.23006619601;12934.159279646816;12958.805617915727;12969.416376263067;13104.41030153643;11884.108691848125;12207.20653157544;12210.32843193624;12251.877481225185;12254.387280635978;646.6508085633752;782.3311069035977;791.1850793682516;806.1253539909205;807.7859367267679;809.6275713171948;809.8339840332748;813.1340122769261;813.8738495533172;815.0626779203903;837.9832403351929;844.6832437835811;845.4589062999654;845.4758050009003;846.124261389462;672.7947975867359;827.185222555782;840.2269911681268;841.4152164245852;853.3983541603155;619.0373968479013;620.736187120472;623.2614351992903;623.5448122870284;623.7411474238186;11808.173427860052;11869.52521899123;11892.881071189264;11894.107941904305;11897.702557436047;12753.489860405572;13093.738125237538;13187.670308242275;13241;13372.665683357896;9957.352772069793;9986.251031172691;10142.594296228142;10160.695179144564;10330.173586113093;4169.624733773944;4195.853145139906;4203.6637069034405;4209.621134097946;4382;49357;50250.497495024945;50303.24545131826;50347.24479132816;50369.496305036846;8985.550722463851;9096.408733432305;9136.908630913738;9249.075092490697;9496.382735122195;16211;16251.756223656655;16254.837451625568;16260.349586016664;16261;6606.933930660728;6745.898811517831;6746.696398662072;6859.485538584626;6901.447884169354;3832.885013449601;3882;3917.9608203918165;3920.353141731582;3989.5810939851476;2681;2766.3084228942766;2769.62610047645;2772.057500449857;2773.9306517337227;469.1133757198897;481.56177878130734;481.58583618088414;500.7721486723532;501.8469366843148;531.7155321902763;559.7425184415133;575.1602660116193;583.6468936293481;587.8001479496992;7456.291652293024;7656.9617151915;7808.219178082147;7940;8243.752687419386;491.42994126812727;545.4109561673383;559.7788873395068;572.7880684146892;611.1962768958805;3831.65515103642;3847.461355410245;3884.6309600587897;3926.293267211929;4257.446531950888;46825.5317446828;51438;51852;52554.47445525496;53280.73359633177;45421;45652;45852.77073614611;45982.77008614936;46985.53014469812;41295;41550;42596.78701606534;42774.358384624255;44827.32759008552;8510.61702223389;8669.176428239307;8843.248323892542;8930.553472326488;8995.820083598423;29358.706412935597;29441.675124619014;29948.70051299459;29999.70000299969;30080.097597072123;36995;40241.79879100703;40344;40877.38683919803;41099;10849.349039057683;11010.724731881446;11159.051480624237;11211.327320360804;11606.651800446;12147.271163730204;12527.686807829512;12542.435590398636;12676.23942563449;13104.082714209913;7529.249148442471;9958.950205248928;10557.947210264207;10650.627228046982;10710.839337410102;9538.475383853676;9599.280053995839;9923.1069203772;10076.848847267443;10334.914833942328;10300;10736.033756961911;11004.39475828805;11014.3942083183;11016.669499915015;9237.58430870599;9542.42745435276;9701.369410988264;9752.644579416663;10185.185185185315;9250.768730781785;9995.200383969119;10027;10035.949820250851;10073.899261007296 02:57:05 INFO - PROCESS | 21672 | __end_tp_report 02:57:05 INFO - PROCESS | 21672 | __start_cc_report 02:57:05 INFO - PROCESS | 21672 | _x_x_mozilla_cycle_collect,1081 02:57:05 INFO - PROCESS | 21672 | __end_cc_report 02:57:05 INFO - PROCESS | 21672 | __startTimestamp1461059825955__endTimestamp 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | ------- Summary: start ------- 02:57:05 INFO - PROCESS | 21672 | Number of tests: 6 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | [#0] dojo.html Cycles:165 Average:4563.71 Median:4699.22 stddev:469.20 (10.0%) stddev-sans-first:444.41 02:57:05 INFO - PROCESS | 21672 | Values: 2591.7 2658.4 2669.6 2682.7 2704.8 4502.6 4549.7 4554.7 4557.5 4561.4 4599.8 4609.9 4680.1 4690.2 4697.1 4177.4 4214.3 4237.0 4288.9 4361.9 4335.0 4366.2 4379.7 4396.4 4405.4 4154.6 4201.8 4216.5 4257.5 4303.5 4213.2 4243.0 4244.1 4248.9 4273.2 4210.5 4246.1 4250.3 4260.9 4295.7 4386.8 4492.6 4553.8 4556.5 4564.9 4892.6 4916.8 4935.0 4936.8 4979.6 4916.0 4945.5 4946.2 4966.4 4997.3 4511.5 4605.8 4645.1 4678.5 4690.8 5030.8 5038.4 5049.4 5057.0 5057.5 4856.3 4860.7 4865.5 4866.9 4912.4 4820.0 4940.8 4970.5 5003.5 5025.7 4780.2 4804.5 4809.0 4833.7 4850.0 4757.7 4796.2 4799.3 4804.4 4850.9 4124.2 4133.0 4164.4 4200.5 4205.2 3616.2 3638.3 3639.5 3665.2 3681.4 4197.7 4224.4 4226.6 4233.8 4263.9 4927.6 4979.6 4983.9 5030.7 5032.3 4222.6 4236.7 4236.9 4240.0 4285.6 4339.3 4411.9 4413.0 4414.7 4444.8 4719.5 4725.0 4725.9 4763.8 4768.7 4943.5 4982.0 4987.5 4988.7 5028.5 4567.6 4664.2 4684.2 4692.8 4743.5 4929.2 4929.6 4940.4 4949.2 4998.0 4984.7 4996.2 5000.9 5008.4 5068.6 4656.9 4738.7 4788.9 4843.7 4918.7 4765.2 4772.1 4782.0 4821.8 4823.2 4709.6 4709.8 4723.5 4754.2 4762.0 4658.8 4791.8 4797.3 4873.0 4885.4 4685.5 4699.2 4710.0 4716.4 4767.3 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | [#1] ext.html Cycles:180 Average:39870.43 Median:34746.30 stddev:61921.13 (178.2%) stddev-sans-first:62024.56 02:57:05 INFO - PROCESS | 21672 | Values: 581.5 594.0 612.4 617.7 621.2 25966.2 26431.5 26438.0 26477.5 26488.3 35097.8 35276.3 35902.0 36036.5 36080.0 7616.4 7772.8 7791.4 7792.8 7795.3 7341.9 7641.0 7780.1 7798.2 9759.8 9776.4 9886.2 9889.3 9894.6 9894.9 9615.9 9736.6 9745.8 9747.8 9749.7 9643.2 9762.0 9765.5 9768.1 9772.6 34924.8 35174.8 35235.3 35235.6 38583.4 3047.2 3066.0 3083.2 3349.0 3373.1 28565.7 28733.6 28907.4 29168.3 29919.6 3124.1 3128.0 3167.3 3205.0 3244.7 174418.0 175042.0 175377.0 175461.0 176244.0 54315.7 54868.0 54877.5 54901.0 54905.2 56702.4 57066.7 57471.4 57589.7 57596.4 15286.6 15497.8 15511.7 15517.5 15524.8 10135.0 10213.4 10227.5 10229.3 10323.2 16172.6 17161.3 17400.7 17407.3 17426.7 5835.7 6007.9 6071.3 6084.2 6162.1 909.7 961.5 964.7 1017.1 1049.2 28097.7 28251.6 28489.4 28496.6 28743.7 961.3 981.6 1025.2 1047.1 1077.1 14368.9 15059.4 15098.4 15347.8 15387.2 303918.0 307606.0 309357.0 309372.0 310224.0 49306.5 50468.0 50543.5 50556.0 50645.5 1060.2 1159.0 1184.2 1237.5 1274.8 26964.6 27579.7 28180.3 28409.6 28525.3 40203.0 40340.8 40687.6 40919.6 40945.4 205789.0 207393.0 207592.0 207694.0 208796.0 31891.8 32956.5 36455.0 37780.6 37804.4 39528.6 40394.6 40888.2 40968.0 41170.4 34427.7 34530.3 34706.5 35043.0 35344.6 34573.3 34786.1 35061.6 35239.6 35488.0 35185.3 35427.0 35739.0 37636.4 39257.2 29330.6 31021.7 31411.5 31461.0 31704.5 24405.2 24459.6 24851.9 26334.6 27916.9 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | [#2] jquery.html Cycles:180 Average:22648.85 Median:28136.36 stddev:57698.64 (205.1%) stddev-sans-first:57836.28 02:57:05 INFO - PROCESS | 21672 | Values: 381.9 385.9 386.4 396.6 401.8 12933.4 13552.8 15660.9 16731.6 16749.1 15443.4 15630.1 15714.7 15735.1 16280.5 5029.2 5159.2 5196.6 5196.8 5222.9 5013.7 5206.1 5214.8 5227.5 5233.4 5126.4 5190.5 5191.0 5194.9 5195.7 4994.3 5094.9 5097.0 5150.5 5150.9 4578.4 4583.3 4589.5 4594.3 4607.9 11798.2 12426.3 12456.1 12459.1 12480.9 1784.3 1788.8 1823.2 1853.3 1990.2 9010.0 9047.9 9119.1 9456.2 9626.3 1693.6 1815.3 1916.9 1984.1 1988.0 64558.0 66049.3 68116.7 68695.7 69590.0 9883.3 10007.2 10137.4 10193.8 10257.6 12350.3 12887.9 14029.3 14315.9 14357.1 6511.8 6780.4 6905.8 7340.4 7441.3 6851.4 6880.9 7046.4 7134.1 7147.7 4275.4 4276.4 4326.4 4356.8 4420.2 1779.2 1843.9 1848.2 1857.3 1875.4 879.1 885.6 954.5 969.8 994.1 15337.5 16842.6 16852.0 17084.6 17174.4 876.6 880.3 886.7 901.4 951.4 9131.7 9233.3 9388.0 9432.7 9642.1 304854.0 312953.0 355473.0 374281.0 377137.0 79361.6 82525.2 84477.6 84818.6 86703.6 950.6 963.2 978.3 993.9 996.1 14952.3 14995.6 15313.5 15362.2 15553.1 34355.5 35435.3 35773.5 35937.1 36477.5 46267.3 48528.0 50907.2 51175.7 51241.7 7209.3 7227.0 7418.6 7422.8 7582.7 9864.6 10776.9 11050.7 11098.9 11099.4 9579.2 9670.1 9727.7 9806.5 9977.3 9757.6 9793.8 9809.4 9884.9 9898.3 9863.1 9886.7 10115.4 10178.5 10262.0 6906.9 6916.7 7092.2 7100.1 7109.8 8530.8 9809.6 9953.6 10021.9 10079.7 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | [#3] mootools.html Cycles:180 Average:5095.16 Median:4821.95 stddev:2805.35 (58.2%) stddev-sans-first:2798.62 02:57:05 INFO - PROCESS | 21672 | Values: 1288.3 1402.3 1458.0 1517.9 1752.2 6564.8 7576.7 7742.7 7813.9 7821.2 7439.4 7752.1 7754.7 7755.6 7757.7 1954.4 2202.7 2239.9 2268.3 2280.2 2286.5 2310.7 2312.3 2313.9 2315.6 2214.1 2263.6 2267.8 2268.5 2268.6 1915.2 2126.1 2187.0 2196.0 2198.7 2170.9 2189.3 2193.6 2213.9 2242.0 7713.3 7718.5 7731.0 7792.8 7801.0 4662.8 4818.8 4825.1 4826.5 4853.2 2931.3 2953.8 2978.8 3033.6 3050.7 913.9 1657.1 1702.6 1706.8 1709.8 10048.9 10258.8 10260.7 10265.7 10303.4 4029.8 4071.2 4168.4 4181.2 4194.7 8175.7 8179.3 8213.8 8215.7 8439.5 4122.9 4732.2 4749.9 4754.4 4758.3 4229.7 4313.7 4316.7 4340.8 4342.8 3517.7 3520.5 3593.7 3629.7 3661.7 1080.9 1088.4 1096.2 1112.8 1115.7 805.8 837.5 838.8 842.9 854.9 5151.6 5213.0 5301.9 5303.6 5464.3 422.4 432.2 435.2 439.5 442.2 3592.5 3650.9 3652.3 3694.3 3716.9 9362.3 9777.0 9813.1 9845.9 9866.8 9616.1 9715.0 9719.8 9739.0 9748.4 7333.0 7434.8 7436.7 7445.7 7501.5 5068.2 5085.8 5258.3 5289.8 5316.1 8949.6 8983.4 8992.6 9058.7 9088.2 8703.2 9041.2 9200.8 9231.5 9239.9 5834.3 6030.2 6052.7 6489.4 6533.3 6550.9 7124.2 7349.0 7354.3 7362.7 6560.8 6573.0 6695.8 6711.6 6857.5 6640.6 6659.2 6659.7 6665.6 6698.2 6044.3 6101.6 6103.5 6109.8 6154.8 4363.9 4469.6 4612.1 4617.9 4678.9 4553.7 4619.4 4661.1 4695.2 4721.3 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | [#4] prototype.html Cycles:180 Average:4437.24 Median:5068.21 stddev:1302.53 (25.7%) stddev-sans-first:1268.86 02:57:05 INFO - PROCESS | 21672 | Values: 312.2 312.3 313.5 319.7 319.8 5056.5 5124.6 5127.1 5136.6 5141.9 5060.4 5060.6 5061.8 5065.2 5071.2 3763.7 3826.7 3990.6 3992.3 4013.7 3948.2 3975.6 3982.4 3986.8 3990.9 3735.2 3959.6 3962.2 3965.2 3967.5 3806.3 3972.1 3978.6 3979.7 3982.5 3500.3 3502.8 3509.1 3512.5 3525.2 4871.3 4874.0 4890.8 4893.2 4901.3 4240.9 4501.0 4505.4 4530.0 4596.1 5327.2 5327.5 5337.8 5338.9 5345.0 3772.4 3774.4 3775.9 3783.3 3793.2 5534.3 5539.9 5589.7 5593.6 5607.5 3810.1 3819.8 3843.2 3847.2 3852.9 3843.6 3878.8 3885.4 3895.4 3907.4 4196.4 4442.4 4473.3 4484.1 4484.4 5330.5 5336.0 5339.7 5348.5 5358.6 1328.0 1340.6 1350.6 1356.4 1361.4 844.5 883.3 900.4 910.7 922.6 4646.4 4675.3 4682.9 4686.9 4691.3 5496.4 5497.8 5502.4 5505.3 5513.6 4491.3 4675.7 4683.7 4699.0 4715.9 2962.6 2978.6 2984.5 2991.9 2997.1 5277.1 5277.8 5280.6 5281.3 5281.8 5513.5 5711.7 5721.9 5732.9 5735.5 5244.1 5253.2 5253.4 5255.5 5258.7 5424.8 5559.7 5573.6 5583.2 5587.2 5425.6 5437.3 5451.8 5473.9 5477.9 5185.6 5212.9 5226.0 5235.6 5240.3 3773.4 3836.5 3862.7 3868.9 3877.5 5530.7 5541.6 5549.4 5553.9 5555.6 5345.2 5368.5 5374.2 5380.5 5404.0 5278.8 5310.5 5373.9 5374.2 5374.9 5004.3 5239.7 5261.0 5270.9 5279.6 5184.0 5336.8 5420.3 5421.6 5425.0 5271.0 5283.1 5286.4 5298.4 5299.2 02:57:05 INFO - PROCESS | 21672 | 02:57:05 INFO - PROCESS | 21672 | [#5] yui.html Cycles:180 Average:12877.66 Median:46404.15 stddev:14661.48 (31.6%) stddev-sans-first:14673.73 02:57:05 INFO - PROCESS | 21672 | Values: 622.1 679.4 773.4 777.2 794.4 12832.2 12934.2 12958.8 12969.4 13104.4 11884.1 12207.2 12210.3 12251.9 12254.4 646.7 782.3 791.2 806.1 807.8 809.6 809.8 813.1 813.9 815.1 838.0 844.7 845.5 845.5 846.1 672.8 827.2 840.2 841.4 853.4 619.0 620.7 623.3 623.5 623.7 11808.2 11869.5 11892.9 11894.1 11897.7 12753.5 13093.7 13187.7 13241.0 13372.7 9957.4 9986.3 10142.6 10160.7 10330.2 4169.6 4195.9 4203.7 4209.6 4382.0 49357.0 50250.5 50303.2 50347.2 50369.5 8985.6 9096.4 9136.9 9249.1 9496.4 16211.0 16251.8 16254.8 16260.3 16261.0 6606.9 6745.9 6746.7 6859.5 6901.4 3832.9 3882.0 3918.0 3920.4 3989.6 2681.0 2766.3 2769.6 2772.1 2773.9 469.1 481.6 481.6 500.8 501.8 531.7 559.7 575.2 583.6 587.8 7456.3 7657.0 7808.2 7940.0 8243.8 491.4 545.4 559.8 572.8 611.2 3831.7 3847.5 3884.6 3926.3 4257.4 46825.5 51438.0 51852.0 52554.5 53280.7 45421.0 45652.0 45852.8 45982.8 46985.5 41295.0 41550.0 42596.8 42774.4 44827.3 8510.6 8669.2 8843.2 8930.6 8995.8 29358.7 29441.7 29948.7 29999.7 30080.1 36995.0 40241.8 40344.0 40877.4 41099.0 10849.3 11010.7 11159.1 11211.3 11606.7 12147.3 12527.7 12542.4 12676.2 13104.1 7529.2 9959.0 10557.9 10650.6 10710.8 9538.5 9599.3 9923.1 10076.8 10334.9 10300.0 10736.0 11004.4 11014.4 11016.7 9237.6 9542.4 9701.4 9752.6 10185.2 9250.8 9995.2 10027.0 10035.9 10073.9 02:57:05 INFO - PROCESS | 21672 | -------- Summary: end -------- 02:57:05 INFO - PROCESS | 21672 | 02:57:06 INFO - TEST-INFO | 21672: exit 0 02:57:06 INFO - TEST-OK | dromaeo_css | took 1118715ms 02:57:06 INFO - TEST-START | kraken 02:57:06 INFO - operating with platform_type : linux_ 02:57:06 INFO - Initialising browser for kraken test... 02:57:06 INFO - TEST-INFO | started process 21850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkTMPCE/profile http://localhost:34800/getInfo.html) 02:57:11 INFO - PROCESS | 21850 | __metrics Screen width/height:1600/1200 02:57:11 INFO - PROCESS | 21850 | colorDepth:24 02:57:11 INFO - PROCESS | 21850 | Browser inner width/height: 1024/697 02:57:11 INFO - PROCESS | 21850 | __metrics 02:57:12 ERROR - PROCESS | 21850 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:57:13 INFO - TEST-INFO | 21850: exit 0 02:57:13 INFO - Browser initialized. 02:57:13 INFO - Running cycle 1/1 for kraken test... 02:57:13 INFO - TEST-INFO | started process 21931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkTMPCE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:25 INFO - PROCESS | 21931 | RSS: Main: 154832896 02:57:25 INFO - PROCESS | 21931 | 02:57:27 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34800/tests/kraken/driver.html?testName=audio-beat-detection) 02:57:28 INFO - PROCESS | 21931 | RSS: Main: 208584704 02:57:28 INFO - PROCESS | 21931 | 02:57:31 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34800/tests/kraken/driver.html?testName=audio-dft) 02:57:32 INFO - PROCESS | 21931 | RSS: Main: 194629632 02:57:32 INFO - PROCESS | 21931 | 02:57:35 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34800/tests/kraken/driver.html?testName=audio-fft) 02:57:35 INFO - PROCESS | 21931 | RSS: Main: 266223616 02:57:35 INFO - PROCESS | 21931 | 02:57:38 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34800/tests/kraken/driver.html?testName=audio-oscillator) 02:57:38 INFO - PROCESS | 21931 | RSS: Main: 175255552 02:57:38 INFO - PROCESS | 21931 | 02:57:40 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:41 INFO - PROCESS | 21931 | RSS: Main: 178057216 02:57:41 INFO - PROCESS | 21931 | 02:57:44 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34800/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:45 INFO - PROCESS | 21931 | RSS: Main: 214286336 02:57:45 INFO - PROCESS | 21931 | 02:57:48 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34800/tests/kraken/driver.html?testName=imaging-desaturate) 02:57:49 INFO - PROCESS | 21931 | RSS: Main: 215506944 02:57:49 INFO - PROCESS | 21931 | 02:57:52 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34800/tests/kraken/driver.html?testName=json-parse-financial) 02:57:52 INFO - PROCESS | 21931 | RSS: Main: 215715840 02:57:52 INFO - PROCESS | 21931 | 02:57:54 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:57:55 INFO - PROCESS | 21931 | RSS: Main: 201756672 02:57:55 INFO - PROCESS | 21931 | 02:57:57 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:57:57 INFO - PROCESS | 21931 | RSS: Main: 204967936 02:57:57 INFO - PROCESS | 21931 | 02:57:59 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:00 INFO - PROCESS | 21931 | RSS: Main: 217706496 02:58:00 INFO - PROCESS | 21931 | 02:58:03 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:03 INFO - PROCESS | 21931 | RSS: Main: 223838208 02:58:03 INFO - PROCESS | 21931 | 02:58:06 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:58:07 INFO - PROCESS | 21931 | RSS: Main: 219963392 02:58:07 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:34800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34800/tests/kraken/driver.html?testName=ai-astar) 02:58:09 INFO - PROCESS | 21931 | RSS: Main: 282980352 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | __start_tp_report 02:58:09 INFO - PROCESS | 21931 | _x_x_mozilla_page_load 02:58:09 INFO - PROCESS | 21931 | _x_x_mozilla_page_load_details 02:58:09 INFO - PROCESS | 21931 | |i|pagename|runs| 02:58:09 INFO - PROCESS | 21931 | |0;ai-astar;115;116;109;116;115;113;103;113;115;114 02:58:09 INFO - PROCESS | 21931 | |1;audio-beat-detection;155;129;161;185;134;156;167;135;188;132 02:58:09 INFO - PROCESS | 21931 | |2;audio-dft;163;161;171;163;163;161;161;163;165;161 02:58:09 INFO - PROCESS | 21931 | |3;audio-fft;73;78;75;165;74;74;73;77;152;77 02:58:09 INFO - PROCESS | 21931 | |4;audio-oscillator;95;96;142;95;94;94;149;94;94;149 02:58:09 INFO - PROCESS | 21931 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;117;117 02:58:09 INFO - PROCESS | 21931 | |6;imaging-darkroom;147;146;146;147;146;147;146;145;147;146 02:58:09 INFO - PROCESS | 21931 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 02:58:09 INFO - PROCESS | 21931 | |8;json-parse-financial;65;66;66;66;66;66;67;83;65;64 02:58:09 INFO - PROCESS | 21931 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;65;65 02:58:09 INFO - PROCESS | 21931 | |10;stanford-crypto-aes;78;84;78;85;79;79;79;78;79;80 02:58:09 INFO - PROCESS | 21931 | |11;stanford-crypto-ccm;136;131;132;138;136;131;141;145;163;142 02:58:09 INFO - PROCESS | 21931 | |12;stanford-crypto-pbkdf2;185;180;176;173;173;179;183;171;171;172 02:58:09 INFO - PROCESS | 21931 | |13;stanford-crypto-sha256-iterative;76;75;78;72;77;70;73;71;72;71 02:58:09 INFO - PROCESS | 21931 | __end_tp_report 02:58:09 INFO - PROCESS | 21931 | __start_cc_report 02:58:09 INFO - PROCESS | 21931 | _x_x_mozilla_cycle_collect,1906 02:58:09 INFO - PROCESS | 21931 | __end_cc_report 02:58:09 INFO - PROCESS | 21931 | __startTimestamp1461059889560__endTimestamp 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | ------- Summary: start ------- 02:58:09 INFO - PROCESS | 21931 | Number of tests: 14 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#0] ai-astar Cycles:10 Average:112.90 Median:115.00 stddev:4.04 (3.5%) stddev-sans-first:4.21 02:58:09 INFO - PROCESS | 21931 | Values: 115.0 116.0 109.0 116.0 115.0 113.0 103.0 113.0 115.0 114.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:158.50 stddev:21.63 (13.6%) stddev-sans-first:22.94 02:58:09 INFO - PROCESS | 21931 | Values: 155.0 129.0 161.0 185.0 134.0 156.0 167.0 135.0 188.0 132.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:3.05 (1.9%) stddev-sans-first:3.23 02:58:09 INFO - PROCESS | 21931 | Values: 163.0 161.0 171.0 163.0 163.0 161.0 161.0 163.0 165.0 161.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.50 stddev:35.33 (47.4%) stddev-sans-first:36.81 02:58:09 INFO - PROCESS | 21931 | Values: 73.0 78.0 75.0 165.0 74.0 74.0 73.0 77.0 152.0 77.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:94.00 stddev:25.24 (26.9%) stddev-sans-first:26.17 02:58:09 INFO - PROCESS | 21931 | Values: 95.0 96.0 142.0 95.0 94.0 94.0 149.0 94.0 94.0 149.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:58:09 INFO - PROCESS | 21931 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 02:58:09 INFO - PROCESS | 21931 | Values: 147.0 146.0 146.0 147.0 146.0 147.0 146.0 145.0 147.0 146.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 02:58:09 INFO - PROCESS | 21931 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:5.54 (8.4%) stddev-sans-first:5.81 02:58:09 INFO - PROCESS | 21931 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 67.0 83.0 65.0 64.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 02:58:09 INFO - PROCESS | 21931 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.51 (3.2%) stddev-sans-first:2.57 02:58:09 INFO - PROCESS | 21931 | Values: 78.0 84.0 78.0 85.0 79.0 79.0 79.0 78.0 79.0 80.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:139.50 stddev:9.54 (6.8%) stddev-sans-first:10.03 02:58:09 INFO - PROCESS | 21931 | Values: 136.0 131.0 132.0 138.0 136.0 131.0 141.0 145.0 163.0 142.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:177.50 stddev:5.14 (2.9%) stddev-sans-first:4.39 02:58:09 INFO - PROCESS | 21931 | Values: 185.0 180.0 176.0 173.0 173.0 179.0 183.0 171.0 171.0 172.0 02:58:09 INFO - PROCESS | 21931 | 02:58:09 INFO - PROCESS | 21931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:74.00 stddev:2.80 (3.8%) stddev-sans-first:2.82 02:58:09 INFO - PROCESS | 21931 | Values: 76.0 75.0 78.0 72.0 77.0 70.0 73.0 71.0 72.0 71.0 02:58:09 INFO - PROCESS | 21931 | -------- Summary: end -------- 02:58:09 INFO - PROCESS | 21931 | 02:58:10 INFO - TEST-INFO | 21931: exit 0 02:58:10 INFO - TEST-OK | kraken | took 63851ms 02:58:10 INFO - SUITE-END | took 1182s 02:58:10 INFO - Completed test suite (00:19:42) 02:58:10 INFO - javascript benchmark 02:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.7278685737997, 2658.4417272372802, 2669.639598654181, 2682.6646669166353, 2704.7700945419638, 4502.572255635718, 4549.72701637902, 4554.726716397018, 4557.453105627325, 4561.429821272337, 4599.793009314581, 4609.884752881179, 4680.110778952006, 4690.24956007039, 4697.060587882429, 4177.373393990911, 4214.325707886731, 4237.0254841386495, 4288.914221715564, 4361.869143925672, 4335.0, 4366.1922544329245, 4379.737215767048, 4396.428464299653, 4405.449318835145, 4154.563770804052, 4201.810918508644, 4216.47294088239, 4257.489101307863, 4303.526612072686, 4213.220554197453, 4243.045314804144, 4244.129953359554, 4248.936265955982, 4273.18809426208, 4210.494740631113, 4246.065865509614, 4250.256205164084, 4260.9147817043795, 4295.6778241632, 4386.780660966971, 4492.640588752892, 4553.817847286105, 4556.498785133633, 4564.885877853047, 4892.608591312686, 4916.803327866881, 4935.0, 4936.777844996948, 4979.601631869442, 4916.0, 4945.455999840015, 4946.233333833262, 4966.404031516205, 4997.325361076281, 4511.458624964959, 4605.769711514411, 4645.070985802853, 4678.508756580578, 4690.835820746258, 5030.84907452777, 5038.445770965191, 5049.444561098277, 5057.013882292991, 5057.544820966057, 4856.295837103671, 4860.708357498562, 4865.537773911473, 4866.853994380103, 4912.38595175603, 4820.0, 4940.777665005084, 4970.453250142481, 5003.549680528697, 5025.748712564357, 4780.163471392492, 4804.495527969513, 4809.014152098881, 4833.685810422311, 4849.951500485021, 4757.666963312535, 4796.232602783538, 4799.3041009053495, 4804.447488538863, 4850.927236091461, 4124.237016152021, 4133.028738246509, 4164.3961625564125, 4200.5169405518145, 4205.222033923734, 3616.1863580694135, 3638.272345530904, 3639.526861507987, 3665.2119794244363, 3681.4109742441083, 4197.685173611931, 4224.408582798411, 4226.556211597799, 4233.7671428071135, 4263.936040959388, 4927.605791536668, 4979.601631869442, 4983.900321993612, 5030.723310217973, 5032.295478632995, 4222.641075508616, 4236.724612900151, 4236.894077648022, 4240.024794297329, 4285.592868677533, 4339.305711086211, 4411.867643970686, 4412.977935110304, 4414.735115892992, 4444.755538445352, 4719.480857105647, 4725.0, 4725.881852953635, 4763.833265835679, 4768.737719425465, 4943.480934501826, 4982.003599280086, 4987.476314986874, 4988.72562009093, 5028.472010438852, 4567.634589232787, 4664.230401983635, 4684.203685373426, 4692.812287508598, 4743.478217396015, 4929.162042452864, 4929.580985616263, 4940.431850337257, 4949.232868905326, 4997.9750101249265, 4984.651074424755, 4996.175631020987, 5000.874978125576, 5008.373953255843, 5068.619853510928, 4656.906861862676, 4738.715677059387, 4788.904221915612, 4843.709377437365, 4918.680285781413, 4765.166095933268, 4772.141014617263, 4781.976090119527, 4821.783019764189, 4823.1800593899825, 4709.576138147583, 4709.8116075357975, 4723.456802467623, 4754.21555443348, 4762.023785123972, 4658.767061646972, 4791.760411979457, 4797.2564252540915, 4873.025394921101, 4885.438174609965, 4685.4845966944295, 4699.224627936489, 4709.9529004710885, 4716.410448693913, 4767.308740232577], "value": 4534.840594632956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.4650521520201, 593.9605690042425, 612.3937302070951, 617.7436363908977, 621.2141640824356, 25966.22101336958, 26431.471370572577, 26437.999999999975, 26477.470450590976, 26488.33779155522, 35097.82451087747, 35276.29447411057, 35902.0, 36036.459453108226, 36080.0, 7616.352610028154, 7772.7668169954995, 7791.376689864797, 7792.80517987052, 7795.259450352208, 7341.853162936738, 7641.044869391326, 7780.066392032935, 7798.181190974951, 9759.75600609987, 9776.413415195111, 9886.209103271722, 9889.307748457612, 9894.604215831358, 9894.851577226347, 9615.855762163574, 9736.561854716483, 9745.805083898282, 9747.805043899083, 9749.707508774749, 9643.180329671986, 9762.0, 9765.511724413751, 9768.07203315684, 9772.609095636166, 34924.82537587321, 35174.824125879466, 35235.29529409397, 35235.647643523494, 38583.42124868129, 3047.207725991236, 3065.984670076635, 3083.2137804859617, 3348.96651033489, 3373.1061268763797, 28565.71434285672, 28733.56899646507, 28907.421851562853, 29168.270793230127, 29919.5512067317, 3124.109628755794, 3128.0459459864733, 3167.33485967947, 3205.0, 3244.6755324467363, 174418.0, 175042.0, 175377.0, 175461.0, 176244.0, 54315.72842135764, 54868.0, 54877.45122548803, 54901.0, 54905.176422353696, 56702.43297566971, 57066.7146664264, 57471.425285746605, 57589.71205143948, 57596.39228861681, 15286.617834554225, 15497.767533487007, 15511.689766204612, 15517.45688900883, 15524.844751552566, 10135.0, 10213.387196768217, 10227.539760710786, 10229.335093218917, 10323.174146068297, 16172.595685107966, 17161.31354745796, 17400.73898891518, 17407.303707851544, 17426.738598921027, 5835.737391817378, 6007.879842403127, 6071.332153463116, 6084.239470066242, 6162.106494558264, 909.6543313540944, 961.524075505576, 964.6720115160879, 1017.0947856407803, 1049.228816819637, 28097.735601897555, 28251.57622635662, 28489.43021139607, 28496.572551411744, 28743.712562874523, 961.3414810854587, 981.6367943860818, 1025.1593693171528, 1047.104725459721, 1077.0683358894657, 14368.928155359155, 15059.397624095132, 15098.39606415753, 15347.846521534864, 15387.153706546247, 303918.0, 307606.0, 309357.0, 309372.0, 310224.0, 49306.50693493091, 50468.0, 50543.494565054614, 50556.0, 50645.49354506481, 1060.2472244706346, 1158.9942050289862, 1184.1651635596884, 1237.5359240285072, 1274.8278982337451, 26964.595531066658, 27579.72420275852, 28180.295492612848, 28409.57385639176, 28525.28686782847, 40203.0, 40340.79829600833, 40687.59312406838, 40919.590804091575, 40945.385819213334, 205789.0, 207393.0, 207592.0, 207694.0, 208796.0, 31891.840540797148, 32956.50565241571, 36455.0, 37780.62219377771, 37804.43293350547, 39528.60471395249, 40394.59605403908, 40888.182236354514, 40968.0, 41170.38244426276, 34427.65572344245, 34530.30939381148, 34706.479402809484, 35043.0, 35344.64655353517, 34573.30853382969, 34786.13034674052, 35061.64938350686, 35239.64760352466, 35488.0, 35185.296294074484, 35427.0, 35739.0, 37636.435453468766, 39257.2148557033, 29330.56004159982, 31021.68978310188, 31411.528827067155, 31461.0, 31704.524432133076, 24405.240036096806, 24459.633105503788, 24851.87574062118, 26334.60498092492, 27916.860415697793], "value": 17191.84733629956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.9369803982342, 385.91509867829075, 386.4454507781336, 396.5518963571164, 401.793076565569, 12933.41799619017, 13552.796708049362, 15660.921695391522, 16731.58171045723, 16749.078800665942, 15443.382264709426, 15630.062196268233, 15714.685706285867, 15735.134567598778, 16280.51158465245, 5029.245613158028, 5159.174532074869, 5196.610254230929, 5196.844094677147, 5222.895542089156, 5013.699178049329, 5206.088934436478, 5214.791408343662, 5227.4511176326505, 5233.4243233244315, 5126.384833819928, 5190.506901844319, 5190.974045129769, 5194.896102077956, 5195.6622819516615, 4994.275830004647, 5094.923576146361, 5096.974515127437, 5150.510701483372, 5150.948490515103, 4578.381918441001, 4583.2666773316105, 4589.518100599423, 4594.287885377772, 4607.907841843178, 11798.233114847508, 12426.316552589604, 12456.065795065315, 12459.06557008219, 12480.937595312056, 1784.3041213926579, 1788.8121747216485, 1823.188681036939, 1853.3050106210171, 1990.2337600024096, 9010.0, 9047.909520904772, 9119.088091190893, 9456.243500519942, 9626.326157169002, 1693.6443346897167, 1815.3464752689022, 1916.8945707986056, 1984.1369004483097, 1987.9701804472945, 64558.031629525125, 66049.3395066048, 68116.6594167031, 68695.65652171757, 69590.0, 9883.308168428284, 10007.199424046059, 10137.391756494633, 10193.796124077626, 10257.640982565574, 12350.258984460781, 12887.871121288666, 14029.298535073205, 14315.856841431661, 14357.066790658573, 6511.772087976898, 6780.38976492118, 6905.827354316082, 7340.412766978736, 7441.293077157661, 6851.38337549613, 6880.862382752417, 7046.365827075485, 7134.108236470442, 7147.714091436388, 4275.3800698898485, 4276.444062271885, 4326.3510473428605, 4356.847510337123, 4420.160169567772, 1779.181576474836, 1843.9446816595523, 1848.223746026672, 1857.3499275253553, 1875.37175046361, 879.1077056787366, 885.6059053721033, 954.5036580977853, 969.8011907558933, 994.080475560104, 15337.463188788339, 16842.589260725486, 16852.0, 17084.572885677957, 17174.39889603858, 876.5836227791875, 880.3265501891059, 886.7162507997508, 901.4095767272447, 951.4243882451156, 9131.680391186277, 9233.307501937381, 9387.953060234655, 9432.717018489457, 9642.084002019797, 304854.0, 312953.0, 355473.0, 374281.0, 377137.0, 79361.60319198367, 82525.17474825295, 84477.57761211155, 84818.57590712131, 86703.56648216845, 950.5579905344048, 963.1524258652341, 978.3445091788519, 993.9055789699967, 996.1482932092956, 14952.32714527827, 14995.550133495577, 15313.46402875894, 15362.155081470626, 15553.144577048372, 34355.484667729506, 35435.291294173454, 35773.46339804957, 35937.101572460895, 36477.45283820692, 46267.3059904095, 48528.0, 50907.2363914549, 51175.744121280644, 51241.7437912808, 7209.279072092749, 7226.963865180641, 7418.591977441292, 7422.814429639302, 7582.658780354787, 9864.5560949756, 10776.892231077589, 11050.723731906766, 11098.944505277423, 11099.389533575408, 9579.185769209695, 9670.068858229797, 9727.65953191635, 9806.52902064696, 9977.251706121924, 9757.609695612096, 9793.75515612087, 9809.411435313905, 9884.901150988399, 9898.307118501636, 9863.114762270332, 9886.653967111117, 10115.39307641544, 10178.541965611714, 10262.0, 6906.8618627628175, 6916.723331066701, 7092.184398794205, 7100.112485939258, 7109.75115870942, 8530.786730331543, 9809.558569864515, 9953.552090156105, 10021.949890250502, 10079.69760907174], "value": 7919.416924232206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.27212624867, 1402.340899777105, 1458.0231245065804, 1517.9165145916977, 1752.1939907642475, 6564.770233041839, 7576.659050342734, 7742.651580678869, 7813.882791758128, 7821.2178782121755, 7439.442041846856, 7752.108507521637, 7754.689812407511, 7755.573443460621, 7757.689692412297, 1954.3843689237915, 2202.735671719396, 2239.9216027439, 2268.308166009375, 2280.2019293247395, 2286.4626812699084, 2310.722713274409, 2312.3063081075693, 2313.90744370225, 2315.5947709150914, 2214.1475531920164, 2263.581237471073, 2267.761885002076, 2268.4782500025003, 2268.6029944759684, 1915.205189846212, 2126.1282874021654, 2187.0, 2195.989844671453, 2198.7361516618107, 2170.858894171874, 2189.2665956904457, 2193.5503221839485, 2213.8893055347166, 2241.9775802242093, 7713.305802477804, 7718.498297610693, 7730.961345193295, 7792.844143117106, 7800.960995194988, 4662.8134874604975, 4818.7831547580445, 4825.10735513931, 4826.517348265181, 4853.199222128344, 2931.3404483991144, 2953.8375389353578, 2978.7616990640695, 3033.5601337806115, 3050.66442691306, 913.9086091390874, 1657.0968821992044, 1702.5998890260778, 1706.7525208844647, 1709.7777288952357, 10048.94975525125, 10258.846117308247, 10260.69217923456, 10265.692029239135, 10303.433311167882, 4029.81865816039, 4071.246819338432, 4168.3955826405, 4181.163767246502, 4194.664426845845, 8175.7138500152205, 8179.345652347798, 8213.835723285501, 8215.712450064219, 8439.451435656663, 4122.855700050543, 4732.1718699227495, 4749.857504274877, 4754.358161648202, 4758.333833263346, 4229.661627069827, 4313.741175529478, 4316.69783115179, 4340.804663790137, 4342.761148136819, 3517.683408493248, 3520.507129001942, 3593.6765691087403, 3629.709623230135, 3661.707063434919, 1080.9351438913534, 1088.4122573810055, 1096.1504833753904, 1112.8275117356823, 1115.6653004098737, 805.8468890910708, 837.4975014991079, 838.7861095420628, 842.8735689646602, 854.9016863060704, 5151.6136289778415, 5213.0206315621845, 5301.920471192935, 5303.575713942875, 5464.316960379952, 422.391755871544, 432.2263148963383, 435.1536261970437, 439.545070851667, 442.2415557319213, 3592.497050412944, 3650.8539658413897, 3652.342578335925, 3694.261147770457, 3716.888493345204, 9362.25101991839, 9776.951115244377, 9813.11681948628, 9845.852312215322, 9866.80266394668, 9616.08647178517, 9714.951425242829, 9719.805603887882, 9739.0, 9748.366356186825, 7332.96333518329, 7434.814129646802, 7436.702531898663, 7445.702171913171, 7501.474896757284, 5068.189089745623, 5085.847424577269, 5258.263843061898, 5289.788408463773, 5316.122839731401, 8949.59726812308, 8983.371164018456, 8992.55037248148, 9058.728238152866, 9088.227500662519, 8703.216710496086, 9041.18629323364, 9200.815983680423, 9231.538423078684, 9239.907600923905, 5834.329052159056, 6030.216071910623, 6052.727627256872, 6489.448396886318, 6533.314002029909, 6550.901736473861, 7124.180719217149, 7348.96325518369, 7354.264573542603, 7362.7423040193335, 6560.770373036921, 6572.967135164294, 6695.765648202484, 6711.63086030273, 6857.5199736018, 6640.601563906181, 6659.2008958925235, 6659.733610655519, 6665.600063996176, 6698.229703583956, 6044.274687037584, 6101.60339577926, 6103.481204097701, 6109.816705498843, 6154.753809847735, 4363.890902727458, 4469.575390337913, 4612.146752850734, 4617.9307310389695, 4678.883027924329, 4553.749543775124, 4619.445666520039, 4661.137689527448, 4695.154872123051, 4721.315409265706], "value": 4099.570743038463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.23035218187164, 312.31914426550117, 313.45458901511375, 319.7170504103869, 319.83848156680904, 5056.469070747569, 5124.615653825964, 5127.1027570175165, 5136.614753893459, 5141.871453213672, 5060.41805192403, 5060.645754797166, 5061.797528098881, 5065.240213967907, 5071.1886098224195, 3763.6800871925852, 3826.65560099591, 3990.5610382857863, 3992.281389349916, 4013.6989725770536, 3948.2498325318243, 3975.602439756016, 3982.402639604068, 3986.7607943523335, 3990.900227494307, 3735.234276973214, 3959.6238357356006, 3962.2273656636967, 3965.2466031453932, 3967.5238971323483, 3806.276807406584, 3972.080520817197, 3978.6220309070736, 3979.701522385804, 3982.5021872265966, 3500.2999400119825, 3502.8423720932365, 3509.0700964244497, 3512.4731290306404, 3525.1539630488755, 4871.293662418965, 4873.951260487421, 4890.779914903802, 4893.168161412568, 4901.264810278487, 4240.893977650583, 4500.952066809594, 4505.36924830524, 4530.0, 4596.080783843211, 5327.227552004976, 5327.493888080626, 5337.759800808973, 5338.944506365038, 5344.9732751336, 3772.3775577029755, 3774.358359078963, 3775.924481510382, 3783.2622638585485, 3793.165503589206, 5534.252875861747, 5539.918243935429, 5589.720513974285, 5593.608447408724, 5607.495325420732, 3810.123671555558, 3819.7708137511836, 3843.1929294848396, 3847.249786291646, 3852.8651497197466, 3843.557990831034, 3878.7672739635714, 3885.3783394657285, 3895.376739721631, 3907.374820028782, 4196.370544418301, 4442.42248507692, 4473.329000649928, 4484.1031793641405, 4484.372187893698, 5330.466953304638, 5336.012837624974, 5339.733013349317, 5348.545373643206, 5358.571314294925, 1327.9867201328057, 1340.5509154433373, 1350.5616518407865, 1356.409961666678, 1361.3737680667004, 844.5270648436895, 883.3330835219368, 900.3652425040331, 910.6721580231111, 922.6171138977384, 4646.395968524138, 4675.275332323496, 4682.906341873144, 4686.929696054562, 4691.319758634979, 5496.378568322275, 5497.835064948058, 5502.449755024546, 5505.339359276913, 5513.58648101394, 4491.348754430589, 4675.696079754873, 4683.718976861399, 4699.0, 4715.85852424421, 2962.5852380666724, 2978.627671541057, 2984.4777163996214, 2991.8504074796174, 2997.1158508240123, 5277.1002439121885, 5277.815276465305, 5280.6303558750515, 5281.260623512711, 5281.762320695578, 5513.531349835229, 5711.742971566289, 5721.8569535761935, 5732.856678582985, 5735.483806457355, 5244.108501554745, 5253.1857562077175, 5253.369595648546, 5255.500727430965, 5258.737063146904, 5424.783008679608, 5559.694216818114, 5573.581981351496, 5583.190437386637, 5587.245721827664, 5425.593080518898, 5437.34751829783, 5451.754671039734, 5473.917891231555, 5477.917831232455, 5185.559227465556, 5212.921806172834, 5226.0, 5235.554977826928, 5240.292560504436, 3773.358529050013, 3836.5204349456317, 3862.748921320105, 3868.864589739346, 3877.457155998106, 5530.723463826712, 5541.612087153861, 5549.392894618531, 5553.9444605555045, 5555.611107222456, 5345.1714984177515, 5368.516833485005, 5374.247605335335, 5380.51575358204, 5404.0, 5278.81524146653, 5310.548603368602, 5373.892522149457, 5374.247605335178, 5374.865628359323, 5004.324416203766, 5239.711815850165, 5260.9736951315, 5270.920936185884, 5279.577633789211, 5184.0, 5336.759845807026, 5420.268263784496, 5421.620486565903, 5425.0, 5271.0, 5283.101872681576, 5286.444923283, 5298.3906850712665, 5299.205119231991], "value": 4022.4289253233956, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.0948519903541, 679.3953381490472, 773.3928865840314, 777.1956025513595, 794.3724457678435, 12832.23006619601, 12934.159279646816, 12958.805617915727, 12969.416376263067, 13104.41030153643, 11884.108691848125, 12207.20653157544, 12210.32843193624, 12251.877481225185, 12254.387280635978, 646.6508085633752, 782.3311069035977, 791.1850793682516, 806.1253539909205, 807.7859367267679, 809.6275713171948, 809.8339840332748, 813.1340122769261, 813.8738495533172, 815.0626779203903, 837.9832403351929, 844.6832437835811, 845.4589062999654, 845.4758050009003, 846.124261389462, 672.7947975867359, 827.185222555782, 840.2269911681268, 841.4152164245852, 853.3983541603155, 619.0373968479013, 620.736187120472, 623.2614351992903, 623.5448122870284, 623.7411474238186, 11808.173427860052, 11869.52521899123, 11892.881071189264, 11894.107941904305, 11897.702557436047, 12753.489860405572, 13093.738125237538, 13187.670308242275, 13241.0, 13372.665683357896, 9957.352772069793, 9986.251031172691, 10142.594296228142, 10160.695179144564, 10330.173586113093, 4169.624733773944, 4195.853145139906, 4203.6637069034405, 4209.621134097946, 4382.0, 49357.0, 50250.497495024945, 50303.24545131826, 50347.24479132816, 50369.496305036846, 8985.550722463851, 9096.408733432305, 9136.908630913738, 9249.075092490697, 9496.382735122195, 16211.0, 16251.756223656655, 16254.837451625568, 16260.349586016664, 16261.0, 6606.933930660728, 6745.898811517831, 6746.696398662072, 6859.485538584626, 6901.447884169354, 3832.885013449601, 3882.0, 3917.9608203918165, 3920.353141731582, 3989.5810939851476, 2681.0, 2766.3084228942766, 2769.62610047645, 2772.057500449857, 2773.9306517337227, 469.1133757198897, 481.56177878130734, 481.58583618088414, 500.7721486723532, 501.8469366843148, 531.7155321902763, 559.7425184415133, 575.1602660116193, 583.6468936293481, 587.8001479496992, 7456.291652293024, 7656.9617151915, 7808.219178082147, 7940.0, 8243.752687419386, 491.42994126812727, 545.4109561673383, 559.7788873395068, 572.7880684146892, 611.1962768958805, 3831.65515103642, 3847.461355410245, 3884.6309600587897, 3926.293267211929, 4257.446531950888, 46825.5317446828, 51438.0, 51852.0, 52554.47445525496, 53280.73359633177, 45421.0, 45652.0, 45852.77073614611, 45982.77008614936, 46985.53014469812, 41295.0, 41550.0, 42596.78701606534, 42774.358384624255, 44827.32759008552, 8510.61702223389, 8669.176428239307, 8843.248323892542, 8930.553472326488, 8995.820083598423, 29358.706412935597, 29441.675124619014, 29948.70051299459, 29999.70000299969, 30080.097597072123, 36995.0, 40241.79879100703, 40344.0, 40877.38683919803, 41099.0, 10849.349039057683, 11010.724731881446, 11159.051480624237, 11211.327320360804, 11606.651800446, 12147.271163730204, 12527.686807829512, 12542.435590398636, 12676.23942563449, 13104.082714209913, 7529.249148442471, 9958.950205248928, 10557.947210264207, 10650.627228046982, 10710.839337410102, 9538.475383853676, 9599.280053995839, 9923.1069203772, 10076.848847267443, 10334.914833942328, 10300.0, 10736.033756961911, 11004.39475828805, 11014.3942083183, 11016.669499915015, 9237.58430870599, 9542.42745435276, 9701.369410988264, 9752.644579416663, 10185.185185185315, 9250.768730781785, 9995.200383969119, 10027.0, 10035.949820250851, 10073.899261007296], "value": 5955.600010430563, "unit": "score"}], "name": "dromaeo_css", "value": 6268.00744591388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 109.0, 116.0, 115.0, 113.0, 103.0, 113.0, 115.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 161.0, 185.0, 134.0, 156.0, 167.0, 135.0, 188.0, 132.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 171.0, 163.0, 163.0, 161.0, 161.0, 163.0, 165.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 75.0, 165.0, 74.0, 74.0, 73.0, 77.0, 152.0, 77.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 142.0, 95.0, 94.0, 94.0, 149.0, 94.0, 94.0, 149.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 83.0, 65.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 78.0, 85.0, 79.0, 79.0, 79.0, 78.0, 79.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 132.0, 138.0, 136.0, 131.0, 141.0, 145.0, 163.0, 142.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 176.0, 173.0, 173.0, 179.0, 183.0, 171.0, 171.0, 172.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 72.0, 77.0, 70.0, 73.0, 71.0, 72.0, 71.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1592.2000000000003, "alertThreshold": 2.0}]} 02:58:10 INFO - Return code: 0 02:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:58:10 ERROR - # TBPL SUCCESS # 02:58:10 INFO - Running post-action listener: _resource_record_post_action 02:58:10 INFO - Running post-run listener: _resource_record_post_run 02:58:11 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517492736; Read time: 44; Write time: 970684 02:58:11 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 234196992; Read time: 0; Write time: 634724 02:58:11 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283295744; Read time: 44; Write time: 335960 02:58:11 INFO - Running post-run listener: _upload_blobber_files 02:58:11 INFO - Blob upload gear active. 02:58:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:58:11 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 02:58:11 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:58:11 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:58:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:13 INFO - (blobuploader) - INFO - Done attempting. 02:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:58:13 INFO - (blobuploader) - INFO - Done attempting. 02:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:58:13 INFO - Return code: 0 02:58:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:58:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:58:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f201c85ced668875408d04d66d34353ab05ede08412f87ccdf00999ea46e3e33e6da5e207d0b2ca43ea0ccabfdb3c328c461c41ce616ea777c67498b78220af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aeb50cdf77c5454e1770cf679a1c7888bace6c6bc03f2bd341cec389033319dd24d39f8098691327bc39beadb63ac3e9fe67320eaa98180e0aac53755f288950"} 02:58:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:58:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:58:13 INFO - Contents: 02:58:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f201c85ced668875408d04d66d34353ab05ede08412f87ccdf00999ea46e3e33e6da5e207d0b2ca43ea0ccabfdb3c328c461c41ce616ea777c67498b78220af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aeb50cdf77c5454e1770cf679a1c7888bace6c6bc03f2bd341cec389033319dd24d39f8098691327bc39beadb63ac3e9fe67320eaa98180e0aac53755f288950"} 02:58:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:58:13 INFO - Copying logs to upload dir... 02:58:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:58:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.225469 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-19 02:58:14.019296) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 02:58:14.022418) ========= 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=af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f201c85ced668875408d04d66d34353ab05ede08412f87ccdf00999ea46e3e33e6da5e207d0b2ca43ea0ccabfdb3c328c461c41ce616ea777c67498b78220af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aeb50cdf77c5454e1770cf679a1c7888bace6c6bc03f2bd341cec389033319dd24d39f8098691327bc39beadb63ac3e9fe67320eaa98180e0aac53755f288950"} build_url:https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010117 build_url: 'https://queue.taskcluster.net/v1/task/bZqStvr7QzWV7chpbp5WIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f201c85ced668875408d04d66d34353ab05ede08412f87ccdf00999ea46e3e33e6da5e207d0b2ca43ea0ccabfdb3c328c461c41ce616ea777c67498b78220af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aeb50cdf77c5454e1770cf679a1c7888bace6c6bc03f2bd341cec389033319dd24d39f8098691327bc39beadb63ac3e9fe67320eaa98180e0aac53755f288950"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 02:58:14.052578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:58:14.052888) ========= 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=af724c981e2a0f424dbabf99000001e7-1461057837.425358-772121630 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:58:14.106024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 02:58:14.106353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 02:58:14.106661) ========= ========= Total master_lag: 0.77 =========