builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1461592533.78 results: success (0) buildid: 20160425051150 builduid: f553487030c14d2fb2490c1bdffd6318 revision: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.783920) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.784700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.785162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.834906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.835281) ========= 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=cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 06:55:33-- 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% 103M=0s 2016-04-25 06:55:34 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096557 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.980092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:33.980434) ========= 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=cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013322 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.011346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.011889) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 --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 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 --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=cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 06:55:34,175 truncating revision to first 12 chars 2016-04-25 06:55:34,175 Setting DEBUG logging. 2016-04-25 06:55:34,175 attempt 1/10 2016-04-25 06:55:34,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e75a8ab94a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 06:55:34,448 unpacking tar archive at: fx-team-2e75a8ab94a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.603365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.603778) ========= script_repo_revision: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.604250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.604559) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 06:55:34.618831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-25 06:55:34.619147) ========= /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=cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:55:34 INFO - MultiFileLogger online at 20160425 06:55:34 in /builds/slave/test 06:55:34 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 06:55:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:55:34 INFO - {'append_to_log': False, 06:55:34 INFO - 'base_work_dir': '/builds/slave/test', 06:55:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:55:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:55:34 INFO - 'branch': 'Fx-Team-Non-PGO', 06:55:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:55:34 INFO - 'config_files': ('talos/linux_config.py',), 06:55:34 INFO - 'default_actions': ('clobber', 06:55:34 INFO - 'read-buildbot-config', 06:55:34 INFO - 'download-and-extract', 06:55:34 INFO - 'populate-webroot', 06:55:34 INFO - 'create-virtualenv', 06:55:34 INFO - 'install', 06:55:34 INFO - 'run-tests'), 06:55:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:55:34 INFO - 'download_minidump_stackwalk': True, 06:55:34 INFO - 'download_symbols': 'ondemand', 06:55:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:55:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:55:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:55:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:55:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:55:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:55:34 INFO - 'installer_path': 'installer.exe', 06:55:34 INFO - 'log_level': 'info', 06:55:34 INFO - 'log_name': 'talos', 06:55:34 INFO - 'log_to_console': True, 06:55:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:55:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:55:34 INFO - 'opt_config_files': (), 06:55:34 INFO - 'pip_index': False, 06:55:34 INFO - 'sps_profile': False, 06:55:34 INFO - 'sps_profile_interval': 0, 06:55:34 INFO - 'suite': 'dromaeojs', 06:55:34 INFO - 'system_bits': '32', 06:55:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:55:34 INFO - 'title': 'talos-linux64-ix-054', 06:55:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:55:34 INFO - 'use_talos_json': True, 06:55:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:55:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:55:34 INFO - 'work_dir': 'build'} 06:55:34 INFO - ##### 06:55:34 INFO - ##### Running clobber step. 06:55:34 INFO - ##### 06:55:34 INFO - Running pre-action listener: _resource_record_pre_action 06:55:34 INFO - Running main action method: clobber 06:55:34 INFO - rmtree: /builds/slave/test/build 06:55:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:55:35 INFO - Running post-action listener: _resource_record_post_action 06:55:35 INFO - ##### 06:55:35 INFO - ##### Running read-buildbot-config step. 06:55:35 INFO - ##### 06:55:35 INFO - Running pre-action listener: _resource_record_pre_action 06:55:35 INFO - Running main action method: read_buildbot_config 06:55:35 INFO - Using buildbot properties: 06:55:35 INFO - { 06:55:35 INFO - "project": "", 06:55:35 INFO - "product": "firefox", 06:55:35 INFO - "script_repo_revision": "production", 06:55:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:55:35 INFO - "repository": "", 06:55:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:55:35 INFO - "buildid": "20160425051150", 06:55:35 INFO - "pgo_build": "False", 06:55:35 INFO - "basedir": "/builds/slave/test", 06:55:35 INFO - "buildnumber": 1600, 06:55:35 INFO - "slavename": "talos-linux64-ix-054", 06:55:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:55:35 INFO - "platform": "ubuntu64_hw", 06:55:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:55:35 INFO - "branch": "fx-team", 06:55:35 INFO - "repo_path": "integration/fx-team", 06:55:35 INFO - "revision": "2e75a8ab94a9331d0f84a4a6edb13a7843e904e8", 06:55:35 INFO - "stage_platform": "linux64", 06:55:35 INFO - "builduid": "f553487030c14d2fb2490c1bdffd6318", 06:55:35 INFO - "slavebuilddir": "test" 06:55:35 INFO - } 06:55:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:55:35 INFO - Running post-action listener: _resource_record_post_action 06:55:35 INFO - ##### 06:55:35 INFO - ##### Running download-and-extract step. 06:55:35 INFO - ##### 06:55:35 INFO - Running pre-action listener: _resource_record_pre_action 06:55:35 INFO - Running main action method: download_and_extract 06:55:35 INFO - mkdir: /builds/slave/test/build/tests 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:35 INFO - https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:36 INFO - Downloaded 1361 bytes. 06:55:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:55:36 INFO - Using the following test package requirements: 06:55:36 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:55:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:55:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'jsshell-linux-x86_64.zip'], 06:55:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:55:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:55:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:55:36 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:55:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:55:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:55:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:55:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:55:36 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')]} 06:55:36 INFO - https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:37 INFO - Downloaded 22288052 bytes. 06:55:37 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'] 06:55:37 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 06:55:39 INFO - Return code: 0 06:55:39 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 06:55:39 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')]} 06:55:39 INFO - https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:43 INFO - Downloaded 22288052 bytes. 06:55:43 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'] 06:55:43 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 06:55:45 INFO - Return code: 0 06:55:45 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')]} 06:55:45 INFO - https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:46 INFO - Downloaded 10840145 bytes. 06:55:46 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'] 06:55:46 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 06:55:46 INFO - Return code: 0 06:55:46 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')]} 06:55:46 INFO - https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:55:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:55:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:55:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPbN3eR3QO-n0u256hZeAg/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 06:55:49 INFO - Downloaded 54814586 bytes. 06:55:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:55:49 INFO - mkdir: /builds/slave/test/properties 06:55:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:49 INFO - Contents: 06:55:49 INFO - build_url:https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:55:50 INFO - Running post-action listener: _resource_record_post_action 06:55:50 INFO - Running post-action listener: set_extra_try_arguments 06:55:50 INFO - ##### 06:55:50 INFO - ##### Running populate-webroot step. 06:55:50 INFO - ##### 06:55:50 INFO - Running pre-action listener: _resource_record_pre_action 06:55:50 INFO - Running main action method: populate_webroot 06:55:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:50 INFO - '--tppagecycles', 06:55:50 INFO - '7'], 06:55:50 INFO - 'tests': ['tsvgm']}}, 06:55:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['damp', 'tps']}, 06:55:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'tests': ['damp', 'tps']}, 06:55:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['dromaeo_dom']}, 06:55:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['a11yr', 06:55:50 INFO - 'ts_paint', 06:55:50 INFO - 'tpaint', 06:55:50 INFO - 'sessionrestore', 06:55:50 INFO - 'sessionrestore_no_auto_restore', 06:55:50 INFO - 'tabpaint']}, 06:55:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:50 INFO - 'ts_paint', 06:55:50 INFO - 'tpaint', 06:55:50 INFO - 'sessionrestore', 06:55:50 INFO - 'sessionrestore_no_auto_restore', 06:55:50 INFO - 'tabpaint']}, 06:55:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:50 INFO - 'ts_paint', 06:55:50 INFO - 'tpaint', 06:55:50 INFO - 'sessionrestore', 06:55:50 INFO - 'sessionrestore_no_auto_restore', 06:55:50 INFO - 'tabpaint']}, 06:55:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:50 INFO - 'ts_paint', 06:55:50 INFO - 'tpaint', 06:55:50 INFO - 'sessionrestore', 06:55:50 INFO - 'sessionrestore_no_auto_restore', 06:55:50 INFO - 'tabpaint']}, 06:55:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['a11yr', 06:55:50 INFO - 'ts_paint', 06:55:50 INFO - 'tpaint', 06:55:50 INFO - 'sessionrestore', 06:55:50 INFO - 'sessionrestore_no_auto_restore', 06:55:50 INFO - 'tabpaint']}, 06:55:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['a11yr', 06:55:50 INFO - 'ts_paint', 06:55:50 INFO - 'tpaint', 06:55:50 INFO - 'sessionrestore', 06:55:50 INFO - 'sessionrestore_no_auto_restore', 06:55:50 INFO - 'tabpaint']}, 06:55:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['tsvgx', 06:55:50 INFO - 'tsvgr_opacity', 06:55:50 INFO - 'tart', 06:55:50 INFO - 'tscrollx', 06:55:50 INFO - 'cart']}, 06:55:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:50 INFO - 'tsvgr_opacity', 06:55:50 INFO - 'tart', 06:55:50 INFO - 'tscrollx', 06:55:50 INFO - 'cart']}, 06:55:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'talos_options': ['--disable-e10s'], 06:55:50 INFO - 'tests': ['tp5o']}, 06:55:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'tests': ['tp5o']}, 06:55:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'talos_options': ['--disable-e10s', 06:55:50 INFO - '--xperf_path', 06:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:50 INFO - 'tests': ['tp5n']}, 06:55:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:50 INFO - 'talos_options': ['--xperf_path', 06:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:50 INFO - 'tests': ['tp5n']}}, 06:55:50 INFO - 'talos.zip': {'path': '', 06:55:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:50 INFO - Running post-action listener: _resource_record_post_action 06:55:50 INFO - ##### 06:55:50 INFO - ##### Running create-virtualenv step. 06:55:50 INFO - ##### 06:55:50 INFO - Running pre-action listener: _resource_record_pre_action 06:55:50 INFO - Running main action method: create_virtualenv 06:55:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:50 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 06:55:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:50 INFO - Using real prefix '/usr' 06:55:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:52 INFO - Installing pip.................done. 06:55:52 INFO - Return code: 0 06:55:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55:52 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')]} 06:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:52 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')]} 06:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:52 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:55:52 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 06:55:52 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 06:55:52 INFO - Using env: {'DISPLAY': ':0', 06:55:52 INFO - 'HOME': '/home/cltbld', 06:55:52 INFO - 'LANG': 'en_US.UTF-8', 06:55:52 INFO - 'LANGUAGE': 'en_US:en', 06:55:52 INFO - 'LOGNAME': 'cltbld', 06:55:52 INFO - 'MAIL': '/var/mail/cltbld', 06:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:52 INFO - 'MOZ_NO_REMOTE': '1', 06:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:52 INFO - 'NO_EM_RESTART': '1', 06:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:52 INFO - 'PWD': '/builds/slave/test', 06:55:52 INFO - 'SHELL': '/bin/bash', 06:55:52 INFO - 'SHLVL': '1', 06:55:52 INFO - 'TERM': 'linux', 06:55:52 INFO - 'TMOUT': '86400', 06:55:52 INFO - 'USER': 'cltbld', 06:55:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:52 INFO - '_': '/tools/buildbot/bin/python'} 06:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:53 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 06:55:53 INFO - Cleaning up... 06:55:53 INFO - Return code: 0 06:55:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:55:53 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')]} 06:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:53 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')]} 06:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:53 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:55:53 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 06:55:53 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 06:55:53 INFO - Using env: {'DISPLAY': ':0', 06:55:53 INFO - 'HOME': '/home/cltbld', 06:55:53 INFO - 'LANG': 'en_US.UTF-8', 06:55:53 INFO - 'LANGUAGE': 'en_US:en', 06:55:53 INFO - 'LOGNAME': 'cltbld', 06:55:53 INFO - 'MAIL': '/var/mail/cltbld', 06:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:53 INFO - 'MOZ_NO_REMOTE': '1', 06:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:53 INFO - 'NO_EM_RESTART': '1', 06:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:53 INFO - 'PWD': '/builds/slave/test', 06:55:53 INFO - 'SHELL': '/bin/bash', 06:55:53 INFO - 'SHLVL': '1', 06:55:53 INFO - 'TERM': 'linux', 06:55:53 INFO - 'TMOUT': '86400', 06:55:53 INFO - 'USER': 'cltbld', 06:55:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:53 INFO - '_': '/tools/buildbot/bin/python'} 06:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:53 INFO - Downloading/unpacking psutil>=0.7.1 06:55:53 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 06:55:53 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 06:55:53 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 06:55:53 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 06:55:53 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 06:55:53 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 06:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:55 INFO - Installing collected packages: psutil 06:55:55 INFO - Running setup.py install for psutil 06:55:55 INFO - building 'psutil._psutil_linux' extension 06:55:55 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 06:55:55 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 06:55:55 INFO - building 'psutil._psutil_posix' extension 06:55:55 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 06:55:55 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 06:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:55 INFO - Successfully installed psutil 06:55:55 INFO - Cleaning up... 06:55:55 INFO - Return code: 0 06:55:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:55:55 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')]} 06:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:55 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')]} 06:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:55 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:55:55 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 06:55:55 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 06:55:55 INFO - Using env: {'DISPLAY': ':0', 06:55:55 INFO - 'HOME': '/home/cltbld', 06:55:55 INFO - 'LANG': 'en_US.UTF-8', 06:55:55 INFO - 'LANGUAGE': 'en_US:en', 06:55:55 INFO - 'LOGNAME': 'cltbld', 06:55:55 INFO - 'MAIL': '/var/mail/cltbld', 06:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:55 INFO - 'MOZ_NO_REMOTE': '1', 06:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:55 INFO - 'NO_EM_RESTART': '1', 06:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:55 INFO - 'PWD': '/builds/slave/test', 06:55:55 INFO - 'SHELL': '/bin/bash', 06:55:55 INFO - 'SHLVL': '1', 06:55:55 INFO - 'TERM': 'linux', 06:55:55 INFO - 'TMOUT': '86400', 06:55:55 INFO - 'USER': 'cltbld', 06:55:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:55 INFO - '_': '/tools/buildbot/bin/python'} 06:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:55:58 INFO - Installing collected packages: mozsystemmonitor 06:55:58 INFO - Running setup.py install for mozsystemmonitor 06:55:58 INFO - Successfully installed mozsystemmonitor 06:55:58 INFO - Cleaning up... 06:55:58 INFO - Return code: 0 06:55:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:58 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')]} 06:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:58 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')]} 06:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:58 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:55:58 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 06:55:58 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 06:55:58 INFO - Using env: {'DISPLAY': ':0', 06:55:58 INFO - 'HOME': '/home/cltbld', 06:55:58 INFO - 'LANG': 'en_US.UTF-8', 06:55:58 INFO - 'LANGUAGE': 'en_US:en', 06:55:58 INFO - 'LOGNAME': 'cltbld', 06:55:58 INFO - 'MAIL': '/var/mail/cltbld', 06:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:58 INFO - 'MOZ_NO_REMOTE': '1', 06:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:55:58 INFO - 'NO_EM_RESTART': '1', 06:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:58 INFO - 'PWD': '/builds/slave/test', 06:55:58 INFO - 'SHELL': '/bin/bash', 06:55:58 INFO - 'SHLVL': '1', 06:55:58 INFO - 'TERM': 'linux', 06:55:58 INFO - 'TMOUT': '86400', 06:55:58 INFO - 'USER': 'cltbld', 06:55:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:58 INFO - '_': '/tools/buildbot/bin/python'} 06:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:58 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 06:55:58 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 06:55:58 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 06:55:58 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 06:55:58 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 06:55:58 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 06:56:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:56:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:00 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 06:56:01 INFO - Downloading docopt-0.6.1.tar.gz 06:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:56:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:56:01 INFO - Running setup.py install for blobuploader 06:56:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:56:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:56:01 INFO - Running setup.py install for requests 06:56:01 INFO - Running setup.py install for docopt 06:56:01 INFO - Successfully installed blobuploader requests docopt 06:56:01 INFO - Cleaning up... 06:56:01 INFO - Return code: 0 06:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:01 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')]} 06:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:01 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')]} 06:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:01 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:56:01 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 06:56:01 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 06:56:01 INFO - Using env: {'DISPLAY': ':0', 06:56:01 INFO - 'HOME': '/home/cltbld', 06:56:01 INFO - 'LANG': 'en_US.UTF-8', 06:56:01 INFO - 'LANGUAGE': 'en_US:en', 06:56:01 INFO - 'LOGNAME': 'cltbld', 06:56:01 INFO - 'MAIL': '/var/mail/cltbld', 06:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:01 INFO - 'MOZ_NO_REMOTE': '1', 06:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:01 INFO - 'NO_EM_RESTART': '1', 06:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:01 INFO - 'PWD': '/builds/slave/test', 06:56:01 INFO - 'SHELL': '/bin/bash', 06:56:01 INFO - 'SHLVL': '1', 06:56:01 INFO - 'TERM': 'linux', 06:56:01 INFO - 'TMOUT': '86400', 06:56:01 INFO - 'USER': 'cltbld', 06:56:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:01 INFO - '_': '/tools/buildbot/bin/python'} 06:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:56:01 INFO - Running setup.py (path:/tmp/pip-CwCTTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:56:02 INFO - Running setup.py (path:/tmp/pip-fxzJda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:56:02 INFO - Running setup.py (path:/tmp/pip-erbdV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:56:02 INFO - Running setup.py (path:/tmp/pip-K5kzS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:56:02 INFO - Running setup.py (path:/tmp/pip-iqDLvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:56:02 INFO - Running setup.py (path:/tmp/pip-5m8bcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:56:02 INFO - Running setup.py (path:/tmp/pip-XDWCIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:56:02 INFO - Running setup.py (path:/tmp/pip-SNXgz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:56:02 INFO - Running setup.py (path:/tmp/pip-XB8ZdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:56:02 INFO - Running setup.py (path:/tmp/pip-i7XL5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:56:02 INFO - Running setup.py (path:/tmp/pip-8w9dD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:56:02 INFO - Running setup.py (path:/tmp/pip-OQf11y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:56:02 INFO - Running setup.py (path:/tmp/pip-JPcBGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:56:02 INFO - Running setup.py (path:/tmp/pip-fhM52A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:02 INFO - Running setup.py (path:/tmp/pip-nFUwcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:56:02 INFO - Running setup.py (path:/tmp/pip-qpicW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:56:03 INFO - Running setup.py (path:/tmp/pip-a5ElY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:56:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:56:03 INFO - Running setup.py install for manifestparser 06:56:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Running setup.py install for mozcrash 06:56:03 INFO - Running setup.py install for mozdebug 06:56:03 INFO - Running setup.py install for mozdevice 06:56:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Running setup.py install for mozfile 06:56:03 INFO - Running setup.py install for mozhttpd 06:56:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Running setup.py install for mozinfo 06:56:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Running setup.py install for mozInstall 06:56:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:56:03 INFO - Running setup.py install for mozleak 06:56:04 INFO - Running setup.py install for mozlog 06:56:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Running setup.py install for moznetwork 06:56:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Running setup.py install for mozprocess 06:56:04 INFO - Running setup.py install for mozprofile 06:56:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Running setup.py install for mozrunner 06:56:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Running setup.py install for mozscreenshot 06:56:04 INFO - Running setup.py install for moztest 06:56:04 INFO - Running setup.py install for mozversion 06:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:56:04 INFO - Cleaning up... 06:56:04 INFO - Return code: 0 06:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56: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')]} 06:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56: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')]} 06:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:04 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:56:04 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 06:56:04 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 06:56:04 INFO - Using env: {'DISPLAY': ':0', 06:56:04 INFO - 'HOME': '/home/cltbld', 06:56:04 INFO - 'LANG': 'en_US.UTF-8', 06:56:04 INFO - 'LANGUAGE': 'en_US:en', 06:56:04 INFO - 'LOGNAME': 'cltbld', 06:56:04 INFO - 'MAIL': '/var/mail/cltbld', 06:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:04 INFO - 'MOZ_NO_REMOTE': '1', 06:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:04 INFO - 'NO_EM_RESTART': '1', 06:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:04 INFO - 'PWD': '/builds/slave/test', 06:56:04 INFO - 'SHELL': '/bin/bash', 06:56:04 INFO - 'SHLVL': '1', 06:56:04 INFO - 'TERM': 'linux', 06:56:04 INFO - 'TMOUT': '86400', 06:56:04 INFO - 'USER': 'cltbld', 06:56:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:04 INFO - '_': '/tools/buildbot/bin/python'} 06:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:56:05 INFO - Running setup.py (path:/tmp/pip-IL7EJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:56:05 INFO - Running setup.py (path:/tmp/pip-rbukHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:56:05 INFO - Running setup.py (path:/tmp/pip-m8cJuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:56:05 INFO - Running setup.py (path:/tmp/pip-ZUhV_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:56:05 INFO - Running setup.py (path:/tmp/pip-E8JxpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:56:05 INFO - Running setup.py (path:/tmp/pip-joOZiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:56:05 INFO - Running setup.py (path:/tmp/pip-HhEcYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:56:05 INFO - Running setup.py (path:/tmp/pip-Ohq6Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:56:05 INFO - Running setup.py (path:/tmp/pip-xzLM7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:56:05 INFO - Running setup.py (path:/tmp/pip-0ndjHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:56:05 INFO - Running setup.py (path:/tmp/pip-bgXHRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:56:05 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)) 06:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:56:05 INFO - Running setup.py (path:/tmp/pip-qqlh7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:56:06 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)) 06:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:56:06 INFO - Running setup.py (path:/tmp/pip-e9SHtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:56:06 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)) 06:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:56:06 INFO - Running setup.py (path:/tmp/pip-Te1GAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:56:06 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)) 06:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:06 INFO - Running setup.py (path:/tmp/pip-6KdWNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:06 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)) 06:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:56:06 INFO - Running setup.py (path:/tmp/pip-IJ5DPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:56:06 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)) 06:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:56:06 INFO - Running setup.py (path:/tmp/pip-0yXTXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:56:06 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)) 06:56:06 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)) 06:56:06 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)) 06:56:06 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)) 06:56:06 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)) 06:56:06 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)) 06:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56:08 INFO - Downloading blessings-1.6.tar.gz 06:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:56:08 INFO - Installing collected packages: blessings 06:56:08 INFO - Running setup.py install for blessings 06:56:08 INFO - Successfully installed blessings 06:56:08 INFO - Cleaning up... 06:56:08 INFO - Return code: 0 06:56:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:08 INFO - Reading from file tmpfile_stdout 06:56:08 INFO - Current package versions: 06:56:08 INFO - argparse == 1.2.1 06:56:08 INFO - blessings == 1.6 06:56:08 INFO - blobuploader == 1.2.4 06:56:08 INFO - docopt == 0.6.1 06:56:08 INFO - manifestparser == 1.1 06:56:08 INFO - mozInstall == 1.12 06:56:08 INFO - mozcrash == 0.17 06:56:08 INFO - mozdebug == 0.1 06:56:08 INFO - mozdevice == 0.48 06:56:08 INFO - mozfile == 1.2 06:56:08 INFO - mozhttpd == 0.7 06:56:08 INFO - mozinfo == 0.9 06:56:08 INFO - mozleak == 0.1 06:56:08 INFO - mozlog == 3.1 06:56:08 INFO - moznetwork == 0.27 06:56:08 INFO - mozprocess == 0.22 06:56:08 INFO - mozprofile == 0.28 06:56:08 INFO - mozrunner == 6.11 06:56:08 INFO - mozscreenshot == 0.1 06:56:08 INFO - mozsystemmonitor == 0.0 06:56:08 INFO - moztest == 0.7 06:56:08 INFO - mozversion == 1.4 06:56:08 INFO - psutil == 3.1.1 06:56:08 INFO - requests == 1.2.3 06:56:08 INFO - wsgiref == 0.1.2 06:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:08 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')]} 06:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:08 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')]} 06:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:08 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:56:08 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 06:56:08 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 06:56:08 INFO - Using env: {'DISPLAY': ':0', 06:56:08 INFO - 'HOME': '/home/cltbld', 06:56:08 INFO - 'LANG': 'en_US.UTF-8', 06:56:08 INFO - 'LANGUAGE': 'en_US:en', 06:56:08 INFO - 'LOGNAME': 'cltbld', 06:56:08 INFO - 'MAIL': '/var/mail/cltbld', 06:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:08 INFO - 'MOZ_NO_REMOTE': '1', 06:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:08 INFO - 'NO_EM_RESTART': '1', 06:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:08 INFO - 'PWD': '/builds/slave/test', 06:56:08 INFO - 'SHELL': '/bin/bash', 06:56:08 INFO - 'SHLVL': '1', 06:56:08 INFO - 'TERM': 'linux', 06:56:08 INFO - 'TMOUT': '86400', 06:56:08 INFO - 'USER': 'cltbld', 06:56:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:08 INFO - '_': '/tools/buildbot/bin/python'} 06:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 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)) 06:56:08 INFO - Cleaning up... 06:56:08 INFO - Return code: 0 06:56:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:56:08 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')]} 06:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:08 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')]} 06:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:08 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:56:08 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 06:56:08 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 06:56:08 INFO - Using env: {'DISPLAY': ':0', 06:56:08 INFO - 'HOME': '/home/cltbld', 06:56:08 INFO - 'LANG': 'en_US.UTF-8', 06:56:08 INFO - 'LANGUAGE': 'en_US:en', 06:56:08 INFO - 'LOGNAME': 'cltbld', 06:56:08 INFO - 'MAIL': '/var/mail/cltbld', 06:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:08 INFO - 'MOZ_NO_REMOTE': '1', 06:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:08 INFO - 'NO_EM_RESTART': '1', 06:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:08 INFO - 'PWD': '/builds/slave/test', 06:56:08 INFO - 'SHELL': '/bin/bash', 06:56:08 INFO - 'SHLVL': '1', 06:56:08 INFO - 'TERM': 'linux', 06:56:08 INFO - 'TMOUT': '86400', 06:56:08 INFO - 'USER': 'cltbld', 06:56:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:08 INFO - '_': '/tools/buildbot/bin/python'} 06:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:09 INFO - Downloading/unpacking jsonschema 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:56:11 INFO - Downloading/unpacking functools32 (from jsonschema) 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:56:11 INFO - warning: no files found matching '*.txt' 06:56:11 INFO - no previously-included directories found matching 'build' 06:56:11 INFO - no previously-included directories found matching 'dist' 06:56:11 INFO - no previously-included directories found matching '.git*' 06:56:11 INFO - Installing collected packages: jsonschema, functools32 06:56:11 INFO - Running setup.py install for functools32 06:56:11 INFO - warning: no files found matching '*.txt' 06:56:11 INFO - no previously-included directories found matching 'build' 06:56:11 INFO - no previously-included directories found matching 'dist' 06:56:11 INFO - no previously-included directories found matching '.git*' 06:56:11 INFO - Successfully installed jsonschema functools32 06:56:11 INFO - Cleaning up... 06:56:11 INFO - Return code: 0 06:56:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:11 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 0x7f1e19e6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x204e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', '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 06:56:11 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 06:56:11 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 06:56:11 INFO - Using env: {'DISPLAY': ':0', 06:56:11 INFO - 'HOME': '/home/cltbld', 06:56:11 INFO - 'LANG': 'en_US.UTF-8', 06:56:11 INFO - 'LANGUAGE': 'en_US:en', 06:56:11 INFO - 'LOGNAME': 'cltbld', 06:56:11 INFO - 'MAIL': '/var/mail/cltbld', 06:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:11 INFO - 'MOZ_NO_REMOTE': '1', 06:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:11 INFO - 'NO_EM_RESTART': '1', 06:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:11 INFO - 'PWD': '/builds/slave/test', 06:56:11 INFO - 'SHELL': '/bin/bash', 06:56:11 INFO - 'SHLVL': '1', 06:56:11 INFO - 'TERM': 'linux', 06:56:11 INFO - 'TMOUT': '86400', 06:56:11 INFO - 'USER': 'cltbld', 06:56:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:11 INFO - '_': '/tools/buildbot/bin/python'} 06:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:11 INFO - Downloading/unpacking flake8 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 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 06:56:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:56:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:56:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:13 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 06:56:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:56:14 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 06:56:14 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 06:56:14 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 06:56:14 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 06:56:14 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 06:56:14 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 06:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:56:14 INFO - no previously-included directories found matching 'docs/_build' 06:56:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:56:14 INFO - Running setup.py install for pep8 06:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:56:14 INFO - no previously-included directories found matching 'docs/_build' 06:56:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:56:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:56:14 INFO - Cleaning up... 06:56:14 INFO - Return code: 0 06:56:14 INFO - Running post-action listener: _resource_record_post_action 06:56:14 INFO - Running post-action listener: _start_resource_monitoring 06:56:14 INFO - Starting resource monitoring. 06:56:14 INFO - ##### 06:56:14 INFO - ##### Running install step. 06:56:14 INFO - ##### 06:56:14 INFO - Running pre-action listener: _resource_record_pre_action 06:56:14 INFO - Running main action method: install 06:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:14 INFO - Reading from file tmpfile_stdout 06:56:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:56:14 INFO - Reading from file tmpfile_stdout 06:56:14 INFO - Output received: 06:56:14 INFO - Usage: mozinstall [options] installer 06:56:14 INFO - Options: 06:56:14 INFO - -h, --help show this help message and exit 06:56:14 INFO - -d DEST, --destination=DEST 06:56:14 INFO - Directory to install application into. [default: 06:56:14 INFO - "/builds/slave/test"] 06:56:14 INFO - --app=APP Application being installed. [default: firefox] 06:56:14 INFO - mkdir: /builds/slave/test/build/application 06:56:14 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'] 06:56:14 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 06:56:30 INFO - Reading from file tmpfile_stdout 06:56:30 INFO - Output received: 06:56:30 INFO - /builds/slave/test/build/application/firefox/firefox 06:56:30 INFO - Running post-action listener: _resource_record_post_action 06:56:30 INFO - ##### 06:56:30 INFO - ##### Running run-tests step. 06:56:30 INFO - ##### 06:56:30 INFO - Running pre-action listener: _resource_record_pre_action 06:56:30 INFO - Running main action method: run_tests 06:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:30 INFO - Python 2.7.3 06:56:30 INFO - Return code: 0 06:56:30 INFO - grabbing minidump binary from tooltool 06:56:30 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')]} 06:56:30 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 0x20dd410>, '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 0x20de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20de7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:30 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 06:56:30 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 06:56:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:30 INFO - Return code: 0 06:56:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:56:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:56:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:56:31 INFO - Return code: 0 06:56:31 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/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 06:56:31 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/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 06:56:31 INFO - Using env: {'DISPLAY': ':0', 06:56:31 INFO - 'HOME': '/home/cltbld', 06:56:31 INFO - 'LANG': 'en_US.UTF-8', 06:56:31 INFO - 'LANGUAGE': 'en_US:en', 06:56:31 INFO - 'LOGNAME': 'cltbld', 06:56:31 INFO - 'MAIL': '/var/mail/cltbld', 06:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:31 INFO - 'MOZ_NO_REMOTE': '1', 06:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:56:31 INFO - 'NO_EM_RESTART': '1', 06:56:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:31 INFO - 'PWD': '/builds/slave/test', 06:56:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:31 INFO - 'SHELL': '/bin/bash', 06:56:31 INFO - 'SHLVL': '1', 06:56:31 INFO - 'TERM': 'linux', 06:56:31 INFO - 'TMOUT': '86400', 06:56:31 INFO - 'USER': 'cltbld', 06:56:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453', 06:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:31 INFO - '_': '/tools/buildbot/bin/python'} 06:56:31 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/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 06:56:31 INFO - mozversion application_buildid: 20160425051150 06:56:31 INFO - mozversion application_changeset: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 06:56:31 INFO - mozversion application_display_name: Nightly 06:56:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:31 INFO - mozversion application_name: Firefox 06:56:31 INFO - mozversion application_remotingname: firefox 06:56:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:56:31 INFO - mozversion application_vendor: Mozilla 06:56:31 INFO - mozversion application_version: 48.0a1 06:56:31 INFO - mozversion platform_buildid: 20160425051150 06:56:31 INFO - mozversion platform_changeset: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 06:56:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:56:31 INFO - mozversion platform_version: 48.0a1 06:56:31 INFO - using testdate: 1461592591 06:56:31 INFO - actual date: 1461592591 06:56:31 INFO - starting webserver on 'localhost:36673' 06:56:31 INFO - SUITE-START | Running 2 tests 06:56:31 INFO - TEST-START | dromaeo_css 06:56:31 INFO - operating with platform_type : linux_ 06:56:31 INFO - Initialising browser for dromaeo_css test... 06:56:31 INFO - TEST-INFO | started process 9274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsLFzX/profile http://localhost:36673/getInfo.html) 06:56:36 INFO - PROCESS | 9274 | __metrics Screen width/height:1600/1200 06:56:36 INFO - PROCESS | 9274 | colorDepth:24 06:56:36 INFO - PROCESS | 9274 | Browser inner width/height: 1024/697 06:56:36 INFO - PROCESS | 9274 | __metrics 06:56:37 ERROR - PROCESS | 9274 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:56:38 INFO - TEST-INFO | 9274: exit 0 06:56:38 INFO - Browser initialized. 06:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:38 INFO - TEST-INFO | started process 9354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsLFzX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:50 INFO - PROCESS | 9354 | RSS: Main: 156344320 06:56:50 INFO - PROCESS | 9354 | 06:57:41 INFO - PROCESS | 9354 | 1461592661909 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] 06:59:52 INFO - PROCESS | 9354 | Cycle 1(1): loaded http://localhost:36673/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36673/tests/dromaeo/cssquery-ext.html) 06:59:54 INFO - PROCESS | 9354 | RSS: Main: 325705728 06:59:54 INFO - PROCESS | 9354 | 07:02:56 INFO - PROCESS | 9354 | Cycle 1(1): loaded http://localhost:36673/tests/dromaeo/cssquery-ext.html (next: http://localhost:36673/tests/dromaeo/cssquery-jquery.html) 07:02:57 INFO - PROCESS | 9354 | RSS: Main: 240222208 07:02:57 INFO - PROCESS | 9354 | 07:05:59 INFO - PROCESS | 9354 | Cycle 1(1): loaded http://localhost:36673/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36673/tests/dromaeo/cssquery-mootools.html) 07:06:00 INFO - PROCESS | 9354 | RSS: Main: 231337984 07:06:00 INFO - PROCESS | 9354 | 07:09:02 INFO - PROCESS | 9354 | Cycle 1(1): loaded http://localhost:36673/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36673/tests/dromaeo/cssquery-prototype.html) 07:09:03 INFO - PROCESS | 9354 | RSS: Main: 236974080 07:09:03 INFO - PROCESS | 9354 | 07:12:06 INFO - PROCESS | 9354 | Cycle 1(1): loaded http://localhost:36673/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36673/tests/dromaeo/cssquery-yui.html) 07:12:06 INFO - PROCESS | 9354 | RSS: Main: 224751616 07:12:06 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | Cycle 1(1): loaded http://localhost:36673/tests/dromaeo/cssquery-yui.html (next: http://localhost:36673/tests/dromaeo/cssquery-dojo.html) 07:15:09 INFO - PROCESS | 9354 | RSS: Main: 287653888 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | __start_tp_report 07:15:09 INFO - PROCESS | 9354 | _x_x_mozilla_page_load 07:15:09 INFO - PROCESS | 9354 | _x_x_mozilla_page_load_details 07:15:09 INFO - PROCESS | 9354 | |i|pagename|runs| 07:15:09 INFO - PROCESS | 9354 | |0;dojo.html;2630.671166104237;2702.5946108083785;2702.8108032437735;2717.7554020138173;2740.095768396429;4614.353990441341;4680.906381872361;4711.363965864607;4730.030343779521;4730.266808644661;4692.577668009879;4709.387779588648;4796.520347965202;4819.204831202856;4831.5893149082285;4259.872203833875;4322.524522302544;4324.718893271943;4399.6040356368085;4448.110377924412;4400.339949007643;4418.668599855007;4437.2234858899565;4451.2655411857;4464.866054018385;4234.6823988201;4238.173556156551;4309.525952145262;4313.82744690212;4370.8907277318;4297.935530967038;4307.3108302671735;4315.4605674290715;4333.739975601443;4341.6526677865695;4328.718633288826;4330.458692663417;4353.41228934093;4373.628241599468;4395.077033822901;4482.238019536687;4519.525449827754;4604.815807367701;4648.1865673507;4650.581447669726;5041.294218809369;5044.8234311798915;5052.065367906949;5082.491750824925;5096.311997880276;5050.141475949097;5063.898722025576;5067.949320506785;5073.518015788531;5117.641765076446;4553.54464553542;4688.64835137366;4715.24556071027;4718.528147185289;4792.448868380111;5054.570361519239;5055.51972562606;5078.314427552307;5112.054269960069;5116.232565115188;4824.831130910401;4830.686005409637;4843.491433399513;4868.488808675109;4877.097736918681;4923.630727695438;4929.556339929423;4933.309336692866;4955.1823949048;4968.527989840959;5018.071656743514;5034.521720436553;5040.017196646619;5067.265246539231;5073.315102461121;4981.427135879348;4990.426100998432;4996.600271978233;5003.199488081889;5051.570616497639;4130.132672138824;4248.34150706641;4258.339957306623;4266.616004559604;4316.417283666665;3694.0949467380665;3714.888553343404;3742.120601658608;3778;3825.3879379299733;4403.053343531156;4405.823767049346;4410.360497727876;4437.7781110944325;4453.376527286183;4978.427480839678;5061.848144555669;5070.214116811826;5072.340595722606;5073.3911930568565;4384.4081049058605;4425.070735145591;4435.534268901783;4471.821127154943;4482.596566309048;4516.435445569304;4533.206688829442;4538.52345503724;4577.542245775462;4584.404027476407;4707.905841883212;4750.239961606265;4767.69010014348;4777.402824646919;4781.808727650925;4954.801807927643;4986.252062190701;4994.750262486934;5003.049420610072;5003.899922001612;4696.7886445110735;4722.787474563722;4728.479867214535;4731.881702957316;4778.37881075458;4898.53463920927;4908.9754551227015;4910.582600478856;4965.45380008206;4982.153033984304;5038.949610503848;5056.216286475602;5058.190689489664;5088.923666144937;5114.820981265638;4889.3888263967;4907.901841963069;4909.042736666316;4911.754412279443;4961.8511444656715;4785.258284965836;4881.8535443936735;4890.682105663121;4902.2156454967035;4974.701517908937;4776.689515181502;4788.712677239377;4788.808447662193;4790.640701947298;4799.592034677092;4818.10864989978;4867.269909513601;4868.367112275381;4871.585915197248;4875.878103047452;4777.140114779373;4781.211100168433;4802.495737947465;4861.270809378621;4911.263310503453 07:15:09 INFO - PROCESS | 9354 | |1;ext.html;555.8999380111578;611.5169016476983;614.8401415631936;628.3559351664541;629.3800606402694;33720.831395843015;34934.65065349346;34978.475322870174;35013.299734005304;35238.295234095334;35228.647713522856;35817.820910895476;35858.2828343433;35861.28277434456;35916.64083359166;7545.698172073125;7721.806954826118;7737.226277372246;7740.34207092395;7750.224977502261;7505;7629.351505122071;7629.961850190742;7741.264579864932;7763.107242667081;7765.650545725456;7790.415718821083;7813.804654883645;7844.1763614820475;7846.843063138734;7612.314891659749;7697.576633285195;7731.7680469586;7766.728164514271;7783.688652453895;7832.138464768871;7939.126696063486;7947.642356093932;7953.164917683618;7953.562554059525;36767.81616091929;37382.43926341107;37391;37421.06447338838;37438.25123497542;2823.1953893140358;2951.601533792932;2966;3164.68353164684;3526.347625689256;27166.72833271662;27749.58375624347;27922.441551169068;28351.540456508686;28709.85645071782;3347.782394144373;3375.274316022067;3377.9662203377898;3440.139965008748;3484.9825750871337;204011;205086;205796;206435;206662.40038396616;48676.5132348679;48729.5127048725;48882;49010;49039.75480122648;50798;51466.74266628643;51615;51679.798424189335;51683.741581291855;14247.501337453346;14823.70352592942;14828.110313381232;14838.406463741545;14863.554093377215;11052.392118433403;11162.553497860157;11174.10040293152;11178.944105279421;11179.496922638338;18144.546386340182;18266.26934922588;18403.90798046001;18404.815951840577;18432.170552325177;6687;6977.51157418986;7042.7887163385185;7056.223815380304;7091.184513780878;785.7171418289525;835.8202986357962;869.0266901070842;874.9693760718471;1020.7703266764919;27154.32114197161;27512;27513.587296190573;27546.724532754415;27563.310917226827;928.3779867488798;928.4150984879483;929.0802105915095;969.6121551379505;988.0613417253494;13572.524961626295;14594.708105837824;15082.396704131712;15417.768733469007;15424.151671658166;324071;329093;330964;331403;332671;48046.5195348049;49301.506984930405;49456.50543494591;49572.50427495679;49576.752116239186;1136.4772204785727;1204.6626944455566;1207.8731733168242;1208.4199584199635;1270.980935285953;24849;25390.746092538837;26682.19953401401;27395.589066163626;27552.724472755017;40040.799796000836;40458;40763.38854917119;40802;40802.79598601988;259605;261609;261755;262811;263733;21274.893625531775;21875.671864921722;22832.429189270402;23033;23258.53482930366;35108.64891351054;35219.82390088033;36440.27119457543;36861.631383686894;36953.44569831508;32425.351492969538;32644.183895402806;32864.50703239405;33105.33789324248;33213.16967075843;31566.684333156376;33011.504827428085;34491;34668.13329666779;35139.64860351364;34316;34921.47617785684;34975.300493990486;35036.94889153329;35144.297114058085;30042.948496802506;31381;31560.684393155774;31691.84154079215;31708.207294817814;24238.757612424357;24394.390140246636;24408.63387049231;24894.751052489242;25002.499950001264 07:15:09 INFO - PROCESS | 9354 | |2;jquery.html;376.7344022464163;378.3530163420552;379.4744279173346;381.2013831024004;385.64713287342084;16158.091543522161;16353.591160221;16992.660146797058;17042.147892605368;17067.317307307694;11791.292522448659;15486.225688715576;16289.83710162898;16297.83702162978;16304.83695163048;4056.310427227371;4839.9516004840025;4862.343583616202;4896.951030489703;4897.8775530611665;3423.263998240378;5274.314339135907;5554.833354999357;5567.3040869891265;5573.470520300585;5469.617126801126;5503.504684578387;5513.917291240635;5530.5022547970675;5558;5314.0700377433795;5463.48096930791;5467.398586155519;5473.151661492475;5474.206240095184;3419.384510788057;5117.181250999859;5379.596530260207;5382.1926710993275;5395.5953303502;11756.764864702744;11766.294022358687;11787.469563869647;11900.404979750978;12019.639410817603;1895.1661269041579;1936.0803618281345;2109.9977510682456;2388.713354397466;2421.164698179143;8849.292056635519;9038;9081.772955676095;9270.768230794283;9461.810763784686;1697.8726595505264;1704.2245778170902;1739.8347157020062;1746.7816522934634;1754.491197552721;67475.32524674789;68310.65844670744;69652;70261.99999999949;71249;9939.155171810477;9991.300608957303;10045.598176072876;10330.741731456623;10539.525721342558;13817.585472435843;13916.234607096707;13923.721525569432;13944.790828137586;13965.65085872841;7029.929700702927;7137.10786151731;7175.282471752887;7208.2791720828545;7254.927450725425;6683;6748.4938629602975;6783.932160678429;6883.7590684325805;6894.758683446055;4247.320428731388;4283.528811830696;4288.356746488052;4339.392485052095;4405.118976204772;1736.5571779196478;1771.4419957713278;1802.6935420978466;1840.1811194018533;1845.412944867413;370.31676556752745;390.5372134021194;392.52308445239174;400.9158076803904;741.9740309089156;9711.3202075854;10081.899181008243;10189.694309170736;10203.979602039884;10219.489025548693;394.61525013111986;402.60946881524876;405.0420754914606;409.0183559457267;411.06482751739435;5507.5593952483705;5577.581681373832;5593.105103183471;5604.131359639263;5705.515031222392;334943;336732;340022;359483;360375;74825.25174748183;79319.20680793234;79655.60172199101;80164;80292;415.7817145998375;417.13652738830933;420.0800247458118;420.268732405612;423.5743078206383;9308.301877359361;9310.255438792301;9480.241580673392;9635.518224088908;9708.805823883342;31981.68018319787;32170.126461465155;32655.510167347034;33023;33218.33563328672;48767.5123248763;49358.25962610635;49506.75246623888;49658.503414966835;49736.502634973185;7570.735024274124;7593.468457207942;7769.339606133542;7772.7668169954995;8001.359891208573;8328.3337333012;10262.332948358333;11380.260283081574;11811.881881181078;11849.874261945102;9979.501024948579;9998.300118991601;10244.743881403025;10249.12882405004;10398;10332.17342612574;10375;10380.117689996436;10458.790824183627;10575.576976921146;9990.650327238513;10397.896021039693;10415.323004004715;10585.364878107339;10729.927007299208;7466.887996680162;7572.697092116254;7641.579713115832;7775.455718099905;7786.922130778847;9507.714768556954;9818.361806482555;9858.802823943624;9914.851277230702;10029.348092373972 07:15:09 INFO - PROCESS | 9354 | |3;mootools.html;1255.2656695832936;1434.1896828292015;1449.7752848308512;1580.336258771316;1745.9214335354907;6603.801885943423;7486.55080695158;7653.885191722128;7659.502132361393;7675.846483070349;7647.502912310696;7799.025121859768;7801.6489257983385;7809.6485658145375;7810.492317999326;2204.669299605064;2241.05875532276;2244;2246.853954492961;2249.6175650139517;2203.0747086223823;2232.5646498932715;2250.009995601938;2252.245497758253;2252.9436764080865;2221.633430483976;2234.8323875709307;2236.888155592222;2244.2706120510816;2262.5814224368546;2150.634392153322;2173.1307477009163;2183.7816218378193;2187.759346471879;2189.5183059726833;2140.7538133114736;2145.08833745659;2148.581026699794;2150.290404166621;2152.7309086364203;7545.7358992435;7664.80837979055;7732.729354472623;7741.961290193569;7799.415043871675;4588.609968152711;4732.1718699227495;4736.313234580966;4738.312944623045;4738.312944623045;2882.9855850720824;2913.5192693205595;2916.4458752836895;2947.8083924544835;2970.569267456207;878.6529320918265;879.445949052093;886.561152229644;895.3240303570827;904.8280826642982;10002.899971000343;10388.324758890649;10424.061834434937;10424.426656533888;10466.162706983423;4017.5379831319774;4078.530968938551;4200.327947528381;4201.810918508674;4204.74771513704;8223.588820558949;8311.916880831235;8343.249107580346;8345.624446899905;8352.498850069016;4509.210888094636;4601.562851529099;4643.303504474288;4650.581447669726;4650.837220697259;3751.0622344413896;4072.714909956334;4219.240536703423;4235.724677895989;4269.935950960738;3405.250844814137;3479.0780443182575;3516.9648303516637;3536.717062634983;3538.133157376459;1033.9069483746498;1037.4708898461838;1052.5105825791045;1055.4458909072646;1061.400308825511;677.7560078371782;775.9175949550346;793.186983342079;801.358912869702;823.5840900345407;4799.616030717534;4817.325574419584;4885.487023862514;4937.259411088366;4970.254461830755;399.61037987961504;406.93285607874367;410.32296710427437;411.80645096804454;413.4769516561552;3201.743860491155;3307.6361600223954;3610.945835812465;3747.6252374762853;3811.809409529568;9211.40125891815;9458.621655133718;9674.22606191503;9715.854262186072;9742.07450292221;9364.531773411301;9587.856182157273;9588.472634005057;9625.470599116976;9638.759031024281;7234.782956511313;7368.8894666580045;7373.8156546086775;7432.516886402366;7460.477766556289;5165.870853228699;5246.42289348179;5361.597880159082;5409.459054094559;5498.670079795225;8015.198480151938;8173.836523269621;8260.83478330442;8275.793105172419;8666.393352465268;8294.37792165578;8302.916970830214;8323.084460709197;8374.204450577185;8382.413231073766;5706.629069110661;6024.33732289439;6158.538109641884;6449.258335291502;6632.767853125118;6893.20728116273;6923.480738944499;6923.9307606923285;6964.442844572321;6975.511714179958;5962.1951036611235;6194;6224.751009959551;6336.398042185985;6345.714442850175;6130.2030736004035;6173.351798061319;6211.3167551570195;6304.7162877671535;6316.526260530387;5471.370792358771;5481.095619222943;5524.033294173584;5528.55771538284;5530.198121272473;4074;4124.52567954689;4135.069609337875;4220.493540775126;4238.957610423856;4158.750474971512;4240.893977650583;4311.353297005474;4358.3244597087505;4370.235208838377 07:15:09 INFO - PROCESS | 9354 | |4;prototype.html;310.04660668444524;310.65051816706205;314.1815570439005;314.8236987287119;316.5599816255407;4706.670533062683;4747.715137091773;4756.310335001427;4778.283257511375;4790.257510085934;4682.648801339896;4693.624510039197;4705.85882423527;4716.316134160553;4736.100140973222;3531.1348719563744;3636.2545678136053;3674.889753307405;3759.4548790425374;3767.2088861339153;3709.1654377765058;3739.4577786221116;3743.251349730051;3743.4010558310674;3763.1156678180605;3521.8415171317224;3714.182879766447;3722.143906901414;3725.590185079639;3733.5893051764283;3576.8390422431053;3699.648533389324;3709.8330575124182;3725.5529336479526;3726.5341832270965;3319.668033196685;3320.734341252694;3321.2029113012945;3338.6327503974544;3342.498625206214;4497.865064048051;4511.390962220091;4514.255147900592;4528.977355113237;4533.637309015271;3882.77692526856;4192.559781222958;4217.40956266123;4224.302990006645;4242.2576049191575;4855.830045948375;4937.259411088366;4940.3330550375595;4948.282499037619;4964.280179373971;3496;3518;3533.699635530983;3537.2748586539697;3541.3094446582927;4977.875553111201;5092.210707340369;5115.872103197413;5165.701262937994;5176.7929282828645;3590.8204589770407;3600.8199590020395;3602.8919132426067;3608.9819550902075;3620.8913732588067;3645.4167333226555;3651.904428671388;3656;3660.7254455915913;3666.2218823870403;4119.340905455113;4129.91740165195;4149.97925010373;4164.5210800757695;4174.791260437027;4629.564834901192;4923.655344125948;4925.40895092584;4956.107900577858;4967.453580106186;1320.9063634139804;1331.1680199875077;1334.9733005339838;1335.4791631263815;1336.8596297388829;821.2649678537675;875.1117615620151;895.9328050396247;913.6893456224915;916.4694959417789;4642.396488456479;4649.697769644962;4652.185867473178;4654.185517534418;4670.089332580114;5376.973115134399;5386.946130538723;5391.460853914656;5391.595630327741;5393.892122157535;4532.79602417892;4637.582617564435;4659.370984916993;4676.532346765296;4679.695819771704;2836.9007084752348;2873.827570345786;2874.1664917173784;2875.7699384049224;2887.870045847942;5069.619778516552;5070.873228169326;5075.137226671401;5085.720285384339;5097.974510127426;5300.814471493479;5442;5454.290942177491;5463.262459567907;5498.945010549924;5052.747362631927;5054;5067.290579318825;5079.161938280143;5086.779172998527;5366;5371.167469042305;5378.946210538001;5380.43505431924;5386.407495175606;5050.671706339076;5241.947580524298;5246.42289348179;5256.027634887558;5256.526912577886;5015.774290157025;5050.393952725696;5058.797648094035;5075.6193285502995;5076.263941728503;3779.7354185207873;3780.6030366811087;3784.3377408953875;3786.905327366838;3795.259924314732;4853.902921941471;5116.718580478109;5127.5897928166405;5131.820386286462;5346.679199248058;4945.159322915185;4968.975155124346;4969.552740253394;4970.353853998957;4987.625928055338;4991.5258050485145;4992.500749924979;5014.648974571745;5016.799328026984;5017.297578339108;4646.303054541846;4776.641751868693;4872;4911.214205727067;4927;4867.610591152628;4892.755362231946;4902.730349830794;4910.8281210157475;4937.28409380645;4757.14371413149;4867.610591152628;4877.707337559757;4902.411710594752;4918.843577177279 07:15:09 INFO - PROCESS | 9354 | |5;yui.html;624.8625302433464;685;730.8172956760811;764.762923493717;775.7207405334078;11958.7608247835;12079.879201207985;12162.878371216308;12163.635090947264;12284.508619655215;11776.057915366771;11854.170208085437;11897.34564598949;11906.880931190686;11943.730691168672;635.965021923794;760.0992823504165;782.5695867272991;794.4796158516181;799.8200404908907;791.6833266693311;792.6591565626778;799.2766546275601;799.6361655446758;799.9160088190744;829.274384913201;836.0719601242616;837.1210229259253;837.5728378526934;838.1953324808192;662.3939095727428;801.9839603207903;833.1085738260064;835.2941764209294;835.908050114487;613.3069631316629;616.1189499016405;616.3990109643062;617.718937883262;618.0482057631242;11552.59565915189;11596.652100437;11603.477843496978;11611.6516504505;11629.185956983014;11691.123165762601;12123.636290911287;12582;12620.621381358575;12832.422540985677;9943.90056099437;9948.602055917754;9987.450690212036;10351.58593656253;10403.739906502322;3240.7893486923276;3331.783434076777;3353.7088221034833;3372.5615669962995;3434.21013166973;44834;45128.323075153574;45382.773086134686;45521.317180242324;45609;9340.953295233616;9700.951495242478;9735.756606084904;9816.509174541245;9959.601615935426;16962.66074678524;16966.660666786596;16968.74546881798;16995.40516081931;17012.979221246766;6273.8745225095245;6341.397567231105;6501.31736167705;6710.362515561014;6734;3604.351216780952;3623.655752703489;3672.6694597486353;3708.4437334400054;3762.059485128718;2752.7384898435016;2810.2131403207136;2810.578413238031;2811.2269125990515;2815.352468932157;475.4033687721887;487.51979300389087;490.5143907531518;493.4473389803443;499.3757802746567;496.34234639103335;587.2835141127817;602.3223873142714;614.2352770800383;618.7215752911208;7292.270772922771;7441.800155598543;7614.5575920249985;7675.692972281046;7692.153863075057;529.2854646227639;536.3322663284158;538.9218563308299;550.5210466893748;559.400115669194;3689.7232707546505;3691.4647376130847;3715.8142092895787;3717.2565486902727;3750.774953502744;47204.29193562099;50945.23582146271;52780.73609631927;53890.73054634702;54016.45983540114;45401.31898021532;46641.766791166505;47644.28533571999;47664;48157.75921120372;43519.34720979188;43593.56406435895;43989.78005110018;44276.77861610671;44511.55488445074;6998.475114366341;7074.610896400747;7143.357097861218;7265.200827909031;7398.704051838082;29704.851475742482;30009;30030;30168.54747178838;30222;35053.824730877204;35982.28035439224;37694.62305376911;37793.81103094467;38255.808720956215;9553.331266811256;9762.60949562038;10029.498525073863;10033.598656053677;10162;10433.373997560171;10713.732156696145;10795.460226988462;11329.830052549383;11490.138239631893;9926.335358033984;10140.188784897044;10148.64479743235;10661;11016.228863979444;10701.304415212986;10824.596764209315;11399.145064120059;11400.315981041163;11768;10230.335028223142;10565.577376904837;10925.781484370427;10950.233483656068;11290.15323850698;8897.555122243992;9070.455772653662;9110.407823491452;9303.906960930304;9558.904410955802;8576.742697719079;8626.137386261324;8936.151065648754;9135.817283654156;9176.174144326775 07:15:09 INFO - PROCESS | 9354 | __end_tp_report 07:15:09 INFO - PROCESS | 9354 | __start_cc_report 07:15:09 INFO - PROCESS | 9354 | _x_x_mozilla_cycle_collect,1634 07:15:09 INFO - PROCESS | 9354 | __end_cc_report 07:15:09 INFO - PROCESS | 9354 | __startTimestamp1461593709612__endTimestamp 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | ------- Summary: start ------- 07:15:09 INFO - PROCESS | 9354 | Number of tests: 6 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | [#0] dojo.html Cycles:165 Average:4650.71 Median:4781.21 stddev:466.50 (9.8%) stddev-sans-first:440.20 07:15:09 INFO - PROCESS | 9354 | Values: 2630.7 2702.6 2702.8 2717.8 2740.1 4614.4 4680.9 4711.4 4730.0 4730.3 4692.6 4709.4 4796.5 4819.2 4831.6 4259.9 4322.5 4324.7 4399.6 4448.1 4400.3 4418.7 4437.2 4451.3 4464.9 4234.7 4238.2 4309.5 4313.8 4370.9 4297.9 4307.3 4315.5 4333.7 4341.7 4328.7 4330.5 4353.4 4373.6 4395.1 4482.2 4519.5 4604.8 4648.2 4650.6 5041.3 5044.8 5052.1 5082.5 5096.3 5050.1 5063.9 5067.9 5073.5 5117.6 4553.5 4688.6 4715.2 4718.5 4792.4 5054.6 5055.5 5078.3 5112.1 5116.2 4824.8 4830.7 4843.5 4868.5 4877.1 4923.6 4929.6 4933.3 4955.2 4968.5 5018.1 5034.5 5040.0 5067.3 5073.3 4981.4 4990.4 4996.6 5003.2 5051.6 4130.1 4248.3 4258.3 4266.6 4316.4 3694.1 3714.9 3742.1 3778.0 3825.4 4403.1 4405.8 4410.4 4437.8 4453.4 4978.4 5061.8 5070.2 5072.3 5073.4 4384.4 4425.1 4435.5 4471.8 4482.6 4516.4 4533.2 4538.5 4577.5 4584.4 4707.9 4750.2 4767.7 4777.4 4781.8 4954.8 4986.3 4994.8 5003.0 5003.9 4696.8 4722.8 4728.5 4731.9 4778.4 4898.5 4909.0 4910.6 4965.5 4982.2 5038.9 5056.2 5058.2 5088.9 5114.8 4889.4 4907.9 4909.0 4911.8 4961.9 4785.3 4881.9 4890.7 4902.2 4974.7 4776.7 4788.7 4788.8 4790.6 4799.6 4818.1 4867.3 4868.4 4871.6 4875.9 4777.1 4781.2 4802.5 4861.3 4911.3 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | [#1] ext.html Cycles:180 Average:41880.49 Median:19203.23 stddev:70850.88 (369.0%) stddev-sans-first:70981.69 07:15:09 INFO - PROCESS | 9354 | Values: 555.9 611.5 614.8 628.4 629.4 33720.8 34934.7 34978.5 35013.3 35238.3 35228.6 35817.8 35858.3 35861.3 35916.6 7545.7 7721.8 7737.2 7740.3 7750.2 7505.0 7629.4 7630.0 7741.3 7763.1 7765.7 7790.4 7813.8 7844.2 7846.8 7612.3 7697.6 7731.8 7766.7 7783.7 7832.1 7939.1 7947.6 7953.2 7953.6 36767.8 37382.4 37391.0 37421.1 37438.3 2823.2 2951.6 2966.0 3164.7 3526.3 27166.7 27749.6 27922.4 28351.5 28709.9 3347.8 3375.3 3378.0 3440.1 3485.0 204011.0 205086.0 205796.0 206435.0 206662.4 48676.5 48729.5 48882.0 49010.0 49039.8 50798.0 51466.7 51615.0 51679.8 51683.7 14247.5 14823.7 14828.1 14838.4 14863.6 11052.4 11162.6 11174.1 11178.9 11179.5 18144.5 18266.3 18403.9 18404.8 18432.2 6687.0 6977.5 7042.8 7056.2 7091.2 785.7 835.8 869.0 875.0 1020.8 27154.3 27512.0 27513.6 27546.7 27563.3 928.4 928.4 929.1 969.6 988.1 13572.5 14594.7 15082.4 15417.8 15424.2 324071.0 329093.0 330964.0 331403.0 332671.0 48046.5 49301.5 49456.5 49572.5 49576.8 1136.5 1204.7 1207.9 1208.4 1271.0 24849.0 25390.7 26682.2 27395.6 27552.7 40040.8 40458.0 40763.4 40802.0 40802.8 259605.0 261609.0 261755.0 262811.0 263733.0 21274.9 21875.7 22832.4 23033.0 23258.5 35108.6 35219.8 36440.3 36861.6 36953.4 32425.4 32644.2 32864.5 33105.3 33213.2 31566.7 33011.5 34491.0 34668.1 35139.6 34316.0 34921.5 34975.3 35036.9 35144.3 30042.9 31381.0 31560.7 31691.8 31708.2 24238.8 24394.4 24408.6 24894.8 25002.5 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | [#2] jquery.html Cycles:180 Average:22139.48 Median:2335.45 stddev:57685.44 (2470.0%) stddev-sans-first:57824.12 07:15:09 INFO - PROCESS | 9354 | Values: 376.7 378.4 379.5 381.2 385.6 16158.1 16353.6 16992.7 17042.1 17067.3 11791.3 15486.2 16289.8 16297.8 16304.8 4056.3 4840.0 4862.3 4897.0 4897.9 3423.3 5274.3 5554.8 5567.3 5573.5 5469.6 5503.5 5513.9 5530.5 5558.0 5314.1 5463.5 5467.4 5473.2 5474.2 3419.4 5117.2 5379.6 5382.2 5395.6 11756.8 11766.3 11787.5 11900.4 12019.6 1895.2 1936.1 2110.0 2388.7 2421.2 8849.3 9038.0 9081.8 9270.8 9461.8 1697.9 1704.2 1739.8 1746.8 1754.5 67475.3 68310.7 69652.0 70262.0 71249.0 9939.2 9991.3 10045.6 10330.7 10539.5 13817.6 13916.2 13923.7 13944.8 13965.7 7029.9 7137.1 7175.3 7208.3 7254.9 6683.0 6748.5 6783.9 6883.8 6894.8 4247.3 4283.5 4288.4 4339.4 4405.1 1736.6 1771.4 1802.7 1840.2 1845.4 370.3 390.5 392.5 400.9 742.0 9711.3 10081.9 10189.7 10204.0 10219.5 394.6 402.6 405.0 409.0 411.1 5507.6 5577.6 5593.1 5604.1 5705.5 334943.0 336732.0 340022.0 359483.0 360375.0 74825.3 79319.2 79655.6 80164.0 80292.0 415.8 417.1 420.1 420.3 423.6 9308.3 9310.3 9480.2 9635.5 9708.8 31981.7 32170.1 32655.5 33023.0 33218.3 48767.5 49358.3 49506.8 49658.5 49736.5 7570.7 7593.5 7769.3 7772.8 8001.4 8328.3 10262.3 11380.3 11811.9 11849.9 9979.5 9998.3 10244.7 10249.1 10398.0 10332.2 10375.0 10380.1 10458.8 10575.6 9990.7 10397.9 10415.3 10585.4 10729.9 7466.9 7572.7 7641.6 7775.5 7786.9 9507.7 9818.4 9858.8 9914.9 10029.3 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | [#3] mootools.html Cycles:180 Average:4932.59 Median:4808.47 stddev:2760.72 (57.4%) stddev-sans-first:2754.63 07:15:09 INFO - PROCESS | 9354 | Values: 1255.3 1434.2 1449.8 1580.3 1745.9 6603.8 7486.6 7653.9 7659.5 7675.8 7647.5 7799.0 7801.6 7809.6 7810.5 2204.7 2241.1 2244.0 2246.9 2249.6 2203.1 2232.6 2250.0 2252.2 2252.9 2221.6 2234.8 2236.9 2244.3 2262.6 2150.6 2173.1 2183.8 2187.8 2189.5 2140.8 2145.1 2148.6 2150.3 2152.7 7545.7 7664.8 7732.7 7742.0 7799.4 4588.6 4732.2 4736.3 4738.3 4738.3 2883.0 2913.5 2916.4 2947.8 2970.6 878.7 879.4 886.6 895.3 904.8 10002.9 10388.3 10424.1 10424.4 10466.2 4017.5 4078.5 4200.3 4201.8 4204.7 8223.6 8311.9 8343.2 8345.6 8352.5 4509.2 4601.6 4643.3 4650.6 4650.8 3751.1 4072.7 4219.2 4235.7 4269.9 3405.3 3479.1 3517.0 3536.7 3538.1 1033.9 1037.5 1052.5 1055.4 1061.4 677.8 775.9 793.2 801.4 823.6 4799.6 4817.3 4885.5 4937.3 4970.3 399.6 406.9 410.3 411.8 413.5 3201.7 3307.6 3610.9 3747.6 3811.8 9211.4 9458.6 9674.2 9715.9 9742.1 9364.5 9587.9 9588.5 9625.5 9638.8 7234.8 7368.9 7373.8 7432.5 7460.5 5165.9 5246.4 5361.6 5409.5 5498.7 8015.2 8173.8 8260.8 8275.8 8666.4 8294.4 8302.9 8323.1 8374.2 8382.4 5706.6 6024.3 6158.5 6449.3 6632.8 6893.2 6923.5 6923.9 6964.4 6975.5 5962.2 6194.0 6224.8 6336.4 6345.7 6130.2 6173.4 6211.3 6304.7 6316.5 5471.4 5481.1 5524.0 5528.6 5530.2 4074.0 4124.5 4135.1 4220.5 4239.0 4158.8 4240.9 4311.4 4358.3 4370.2 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | [#4] prototype.html Cycles:180 Average:4190.66 Median:4711.49 stddev:1218.42 (25.9%) stddev-sans-first:1186.52 07:15:09 INFO - PROCESS | 9354 | Values: 310.0 310.7 314.2 314.8 316.6 4706.7 4747.7 4756.3 4778.3 4790.3 4682.6 4693.6 4705.9 4716.3 4736.1 3531.1 3636.3 3674.9 3759.5 3767.2 3709.2 3739.5 3743.3 3743.4 3763.1 3521.8 3714.2 3722.1 3725.6 3733.6 3576.8 3699.6 3709.8 3725.6 3726.5 3319.7 3320.7 3321.2 3338.6 3342.5 4497.9 4511.4 4514.3 4529.0 4533.6 3882.8 4192.6 4217.4 4224.3 4242.3 4855.8 4937.3 4940.3 4948.3 4964.3 3496.0 3518.0 3533.7 3537.3 3541.3 4977.9 5092.2 5115.9 5165.7 5176.8 3590.8 3600.8 3602.9 3609.0 3620.9 3645.4 3651.9 3656.0 3660.7 3666.2 4119.3 4129.9 4150.0 4164.5 4174.8 4629.6 4923.7 4925.4 4956.1 4967.5 1320.9 1331.2 1335.0 1335.5 1336.9 821.3 875.1 895.9 913.7 916.5 4642.4 4649.7 4652.2 4654.2 4670.1 5377.0 5386.9 5391.5 5391.6 5393.9 4532.8 4637.6 4659.4 4676.5 4679.7 2836.9 2873.8 2874.2 2875.8 2887.9 5069.6 5070.9 5075.1 5085.7 5098.0 5300.8 5442.0 5454.3 5463.3 5498.9 5052.7 5054.0 5067.3 5079.2 5086.8 5366.0 5371.2 5378.9 5380.4 5386.4 5050.7 5241.9 5246.4 5256.0 5256.5 5015.8 5050.4 5058.8 5075.6 5076.3 3779.7 3780.6 3784.3 3786.9 3795.3 4853.9 5116.7 5127.6 5131.8 5346.7 4945.2 4969.0 4969.6 4970.4 4987.6 4991.5 4992.5 5014.6 5016.8 5017.3 4646.3 4776.6 4872.0 4911.2 4927.0 4867.6 4892.8 4902.7 4910.8 4937.3 4757.1 4867.6 4877.7 4902.4 4918.8 07:15:09 INFO - PROCESS | 9354 | 07:15:09 INFO - PROCESS | 9354 | [#5] yui.html Cycles:180 Average:12559.50 Median:46923.03 stddev:14451.95 (30.8%) stddev-sans-first:14464.70 07:15:09 INFO - PROCESS | 9354 | Values: 624.9 685.0 730.8 764.8 775.7 11958.8 12079.9 12162.9 12163.6 12284.5 11776.1 11854.2 11897.3 11906.9 11943.7 636.0 760.1 782.6 794.5 799.8 791.7 792.7 799.3 799.6 799.9 829.3 836.1 837.1 837.6 838.2 662.4 802.0 833.1 835.3 835.9 613.3 616.1 616.4 617.7 618.0 11552.6 11596.7 11603.5 11611.7 11629.2 11691.1 12123.6 12582.0 12620.6 12832.4 9943.9 9948.6 9987.5 10351.6 10403.7 3240.8 3331.8 3353.7 3372.6 3434.2 44834.0 45128.3 45382.8 45521.3 45609.0 9341.0 9701.0 9735.8 9816.5 9959.6 16962.7 16966.7 16968.7 16995.4 17013.0 6273.9 6341.4 6501.3 6710.4 6734.0 3604.4 3623.7 3672.7 3708.4 3762.1 2752.7 2810.2 2810.6 2811.2 2815.4 475.4 487.5 490.5 493.4 499.4 496.3 587.3 602.3 614.2 618.7 7292.3 7441.8 7614.6 7675.7 7692.2 529.3 536.3 538.9 550.5 559.4 3689.7 3691.5 3715.8 3717.3 3750.8 47204.3 50945.2 52780.7 53890.7 54016.5 45401.3 46641.8 47644.3 47664.0 48157.8 43519.3 43593.6 43989.8 44276.8 44511.6 6998.5 7074.6 7143.4 7265.2 7398.7 29704.9 30009.0 30030.0 30168.5 30222.0 35053.8 35982.3 37694.6 37793.8 38255.8 9553.3 9762.6 10029.5 10033.6 10162.0 10433.4 10713.7 10795.5 11329.8 11490.1 9926.3 10140.2 10148.6 10661.0 11016.2 10701.3 10824.6 11399.1 11400.3 11768.0 10230.3 10565.6 10925.8 10950.2 11290.2 8897.6 9070.5 9110.4 9303.9 9558.9 8576.7 8626.1 8936.2 9135.8 9176.2 07:15:09 INFO - PROCESS | 9354 | -------- Summary: end -------- 07:15:09 INFO - PROCESS | 9354 | 07:15:10 INFO - TEST-INFO | 9354: exit 0 07:15:10 INFO - TEST-OK | dromaeo_css | took 1118469ms 07:15:10 INFO - TEST-START | kraken 07:15:10 INFO - operating with platform_type : linux_ 07:15:10 INFO - Initialising browser for kraken test... 07:15:10 INFO - TEST-INFO | started process 9532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthHBzw/profile http://localhost:36673/getInfo.html) 07:15:14 INFO - PROCESS | 9532 | __metrics Screen width/height:1600/1200 07:15:14 INFO - PROCESS | 9532 | colorDepth:24 07:15:14 INFO - PROCESS | 9532 | Browser inner width/height: 1024/697 07:15:14 INFO - PROCESS | 9532 | __metrics 07:15:15 ERROR - PROCESS | 9532 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:16 INFO - TEST-INFO | 9532: exit 0 07:15:16 INFO - Browser initialized. 07:15:16 INFO - Running cycle 1/1 for kraken test... 07:15:16 INFO - TEST-INFO | started process 9612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthHBzw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:28 INFO - PROCESS | 9612 | RSS: Main: 156614656 07:15:28 INFO - PROCESS | 9612 | 07:15:31 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36673/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:32 INFO - PROCESS | 9612 | RSS: Main: 210735104 07:15:32 INFO - PROCESS | 9612 | 07:15:34 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36673/tests/kraken/driver.html?testName=audio-dft) 07:15:35 INFO - PROCESS | 9612 | RSS: Main: 196673536 07:15:35 INFO - PROCESS | 9612 | 07:15:38 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36673/tests/kraken/driver.html?testName=audio-fft) 07:15:39 INFO - PROCESS | 9612 | RSS: Main: 267894784 07:15:39 INFO - PROCESS | 9612 | 07:15:41 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36673/tests/kraken/driver.html?testName=audio-oscillator) 07:15:42 INFO - PROCESS | 9612 | RSS: Main: 175443968 07:15:42 INFO - PROCESS | 9612 | 07:15:44 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36673/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:45 INFO - PROCESS | 9612 | RSS: Main: 180031488 07:15:45 INFO - PROCESS | 9612 | 07:15:48 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36673/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:48 INFO - PROCESS | 9612 | RSS: Main: 215646208 07:15:48 INFO - PROCESS | 9612 | 07:15:52 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36673/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:52 INFO - PROCESS | 9612 | RSS: Main: 216825856 07:15:52 INFO - PROCESS | 9612 | 07:15:55 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36673/tests/kraken/driver.html?testName=json-parse-financial) 07:15:56 INFO - PROCESS | 9612 | RSS: Main: 216498176 07:15:56 INFO - PROCESS | 9612 | 07:15:58 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36673/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:58 INFO - PROCESS | 9612 | RSS: Main: 204013568 07:15:58 INFO - PROCESS | 9612 | 07:16:00 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:01 INFO - PROCESS | 9612 | RSS: Main: 208101376 07:16:01 INFO - PROCESS | 9612 | 07:16:03 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:03 INFO - PROCESS | 9612 | RSS: Main: 217210880 07:16:03 INFO - PROCESS | 9612 | 07:16:06 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:16:07 INFO - PROCESS | 9612 | RSS: Main: 221102080 07:16:07 INFO - PROCESS | 9612 | 07:16:10 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:16:10 INFO - PROCESS | 9612 | RSS: Main: 220512256 07:16:10 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | Cycle 1(1): loaded http://localhost:36673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36673/tests/kraken/driver.html?testName=ai-astar) 07:16:12 INFO - PROCESS | 9612 | RSS: Main: 283348992 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | __start_tp_report 07:16:12 INFO - PROCESS | 9612 | _x_x_mozilla_page_load 07:16:12 INFO - PROCESS | 9612 | _x_x_mozilla_page_load_details 07:16:12 INFO - PROCESS | 9612 | |i|pagename|runs| 07:16:12 INFO - PROCESS | 9612 | |0;ai-astar;111;113;108;112;114;113;103;115;111;113 07:16:12 INFO - PROCESS | 9612 | |1;audio-beat-detection;160;134;154;189;132;158;158;133;187;140 07:16:12 INFO - PROCESS | 9612 | |2;audio-dft;162;164;161;162;174;165;164;164;161;164 07:16:12 INFO - PROCESS | 9612 | |3;audio-fft;75;77;104;114;77;74;77;117;105;75 07:16:12 INFO - PROCESS | 9612 | |4;audio-oscillator;94;95;144;95;94;93;147;94;94;146 07:16:12 INFO - PROCESS | 9612 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 07:16:12 INFO - PROCESS | 9612 | |6;imaging-darkroom;145;145;147;146;145;146;147;146;147;146 07:16:12 INFO - PROCESS | 9612 | |7;imaging-desaturate;95;95;95;95;94;96;95;95;95;95 07:16:12 INFO - PROCESS | 9612 | |8;json-parse-financial;66;66;66;66;66;68;66;81;64;76 07:16:12 INFO - PROCESS | 9612 | |9;json-stringify-tinderbox;64;64;65;63;63;63;64;64;70;64 07:16:12 INFO - PROCESS | 9612 | |10;stanford-crypto-aes;78;78;80;77;80;80;88;81;79;79 07:16:12 INFO - PROCESS | 9612 | |11;stanford-crypto-ccm;129;130;128;128;127;127;142;129;210;132 07:16:12 INFO - PROCESS | 9612 | |12;stanford-crypto-pbkdf2;176;180;172;174;179;175;173;173;183;175 07:16:12 INFO - PROCESS | 9612 | |13;stanford-crypto-sha256-iterative;74;72;72;72;76;70;69;72;72;70 07:16:12 INFO - PROCESS | 9612 | __end_tp_report 07:16:12 INFO - PROCESS | 9612 | __start_cc_report 07:16:12 INFO - PROCESS | 9612 | _x_x_mozilla_cycle_collect,1858 07:16:12 INFO - PROCESS | 9612 | __end_cc_report 07:16:12 INFO - PROCESS | 9612 | __startTimestamp1461593772915__endTimestamp 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | ------- Summary: start ------- 07:16:12 INFO - PROCESS | 9612 | Number of tests: 14 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.50 (3.1%) stddev-sans-first:3.71 07:16:12 INFO - PROCESS | 9612 | Values: 111.0 113.0 108.0 112.0 114.0 113.0 103.0 115.0 111.0 113.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:158.00 stddev:20.82 (13.2%) stddev-sans-first:21.99 07:16:12 INFO - PROCESS | 9612 | Values: 160.0 134.0 154.0 189.0 132.0 158.0 158.0 133.0 187.0 140.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.75 (2.3%) stddev-sans-first:3.91 07:16:12 INFO - PROCESS | 9612 | Values: 162.0 164.0 161.0 162.0 174.0 165.0 164.0 164.0 161.0 164.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.00 stddev:18.06 (24.1%) stddev-sans-first:18.38 07:16:12 INFO - PROCESS | 9612 | Values: 75.0 77.0 104.0 114.0 77.0 74.0 77.0 117.0 105.0 75.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.00 stddev:24.91 (26.5%) stddev-sans-first:25.77 07:16:12 INFO - PROCESS | 9612 | Values: 94.0 95.0 144.0 95.0 94.0 93.0 147.0 94.0 94.0 146.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:16:12 INFO - PROCESS | 9612 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 07:16:12 INFO - PROCESS | 9612 | Values: 145.0 145.0 147.0 146.0 145.0 146.0 147.0 146.0 147.0 146.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:16:12 INFO - PROCESS | 9612 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:66.00 stddev:5.48 (8.3%) stddev-sans-first:5.74 07:16:12 INFO - PROCESS | 9612 | Values: 66.0 66.0 66.0 66.0 66.0 68.0 66.0 81.0 64.0 76.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:2.07 (3.2%) stddev-sans-first:2.19 07:16:12 INFO - PROCESS | 9612 | Values: 64.0 64.0 65.0 63.0 63.0 63.0 64.0 64.0 70.0 64.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:3.06 (3.8%) stddev-sans-first:3.15 07:16:12 INFO - PROCESS | 9612 | Values: 78.0 78.0 80.0 77.0 80.0 80.0 88.0 81.0 79.0 79.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:129.50 stddev:25.61 (19.8%) stddev-sans-first:26.95 07:16:12 INFO - PROCESS | 9612 | Values: 129.0 130.0 128.0 128.0 127.0 127.0 142.0 129.0 210.0 132.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:175.50 stddev:3.56 (2.0%) stddev-sans-first:3.77 07:16:12 INFO - PROCESS | 9612 | Values: 176.0 180.0 172.0 174.0 179.0 175.0 173.0 173.0 183.0 175.0 07:16:12 INFO - PROCESS | 9612 | 07:16:12 INFO - PROCESS | 9612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:2.02 (2.8%) stddev-sans-first:2.00 07:16:12 INFO - PROCESS | 9612 | Values: 74.0 72.0 72.0 72.0 76.0 70.0 69.0 72.0 72.0 70.0 07:16:12 INFO - PROCESS | 9612 | -------- Summary: end -------- 07:16:12 INFO - PROCESS | 9612 | 07:16:13 INFO - TEST-INFO | 9612: exit 0 07:16:13 INFO - TEST-OK | kraken | took 63488ms 07:16:13 INFO - SUITE-END | took 1181s 07:16:14 INFO - Completed test suite (00:19:42) 07:16:14 INFO - javascript benchmark 07:16:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.671166104237, 2702.5946108083785, 2702.8108032437735, 2717.7554020138173, 2740.095768396429, 4614.353990441341, 4680.906381872361, 4711.363965864607, 4730.030343779521, 4730.266808644661, 4692.577668009879, 4709.387779588648, 4796.520347965202, 4819.204831202856, 4831.5893149082285, 4259.872203833875, 4322.524522302544, 4324.718893271943, 4399.6040356368085, 4448.110377924412, 4400.339949007643, 4418.668599855007, 4437.2234858899565, 4451.2655411857, 4464.866054018385, 4234.6823988201, 4238.173556156551, 4309.525952145262, 4313.82744690212, 4370.8907277318, 4297.935530967038, 4307.3108302671735, 4315.4605674290715, 4333.739975601443, 4341.6526677865695, 4328.718633288826, 4330.458692663417, 4353.41228934093, 4373.628241599468, 4395.077033822901, 4482.238019536687, 4519.525449827754, 4604.815807367701, 4648.1865673507, 4650.581447669726, 5041.294218809369, 5044.8234311798915, 5052.065367906949, 5082.491750824925, 5096.311997880276, 5050.141475949097, 5063.898722025576, 5067.949320506785, 5073.518015788531, 5117.641765076446, 4553.54464553542, 4688.64835137366, 4715.24556071027, 4718.528147185289, 4792.448868380111, 5054.570361519239, 5055.51972562606, 5078.314427552307, 5112.054269960069, 5116.232565115188, 4824.831130910401, 4830.686005409637, 4843.491433399513, 4868.488808675109, 4877.097736918681, 4923.630727695438, 4929.556339929423, 4933.309336692866, 4955.1823949048, 4968.527989840959, 5018.071656743514, 5034.521720436553, 5040.017196646619, 5067.265246539231, 5073.315102461121, 4981.427135879348, 4990.426100998432, 4996.600271978233, 5003.199488081889, 5051.570616497639, 4130.132672138824, 4248.34150706641, 4258.339957306623, 4266.616004559604, 4316.417283666665, 3694.0949467380665, 3714.888553343404, 3742.120601658608, 3778.0, 3825.3879379299733, 4403.053343531156, 4405.823767049346, 4410.360497727876, 4437.7781110944325, 4453.376527286183, 4978.427480839678, 5061.848144555669, 5070.214116811826, 5072.340595722606, 5073.3911930568565, 4384.4081049058605, 4425.070735145591, 4435.534268901783, 4471.821127154943, 4482.596566309048, 4516.435445569304, 4533.206688829442, 4538.52345503724, 4577.542245775462, 4584.404027476407, 4707.905841883212, 4750.239961606265, 4767.69010014348, 4777.402824646919, 4781.808727650925, 4954.801807927643, 4986.252062190701, 4994.750262486934, 5003.049420610072, 5003.899922001612, 4696.7886445110735, 4722.787474563722, 4728.479867214535, 4731.881702957316, 4778.37881075458, 4898.53463920927, 4908.9754551227015, 4910.582600478856, 4965.45380008206, 4982.153033984304, 5038.949610503848, 5056.216286475602, 5058.190689489664, 5088.923666144937, 5114.820981265638, 4889.3888263967, 4907.901841963069, 4909.042736666316, 4911.754412279443, 4961.8511444656715, 4785.258284965836, 4881.8535443936735, 4890.682105663121, 4902.2156454967035, 4974.701517908937, 4776.689515181502, 4788.712677239377, 4788.808447662193, 4790.640701947298, 4799.592034677092, 4818.10864989978, 4867.269909513601, 4868.367112275381, 4871.585915197248, 4875.878103047452, 4777.140114779373, 4781.211100168433, 4802.495737947465, 4861.270809378621, 4911.263310503453], "value": 4622.3323326265845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8999380111578, 611.5169016476983, 614.8401415631936, 628.3559351664541, 629.3800606402694, 33720.831395843015, 34934.65065349346, 34978.475322870174, 35013.299734005304, 35238.295234095334, 35228.647713522856, 35817.820910895476, 35858.2828343433, 35861.28277434456, 35916.64083359166, 7545.698172073125, 7721.806954826118, 7737.226277372246, 7740.34207092395, 7750.224977502261, 7505.0, 7629.351505122071, 7629.961850190742, 7741.264579864932, 7763.107242667081, 7765.650545725456, 7790.415718821083, 7813.804654883645, 7844.1763614820475, 7846.843063138734, 7612.314891659749, 7697.576633285195, 7731.7680469586, 7766.728164514271, 7783.688652453895, 7832.138464768871, 7939.126696063486, 7947.642356093932, 7953.164917683618, 7953.562554059525, 36767.81616091929, 37382.43926341107, 37391.0, 37421.06447338838, 37438.25123497542, 2823.1953893140358, 2951.601533792932, 2966.0, 3164.68353164684, 3526.347625689256, 27166.72833271662, 27749.58375624347, 27922.441551169068, 28351.540456508686, 28709.85645071782, 3347.782394144373, 3375.274316022067, 3377.9662203377898, 3440.139965008748, 3484.9825750871337, 204011.0, 205086.0, 205796.0, 206435.0, 206662.40038396616, 48676.5132348679, 48729.5127048725, 48882.0, 49010.0, 49039.75480122648, 50798.0, 51466.74266628643, 51615.0, 51679.798424189335, 51683.741581291855, 14247.501337453346, 14823.70352592942, 14828.110313381232, 14838.406463741545, 14863.554093377215, 11052.392118433403, 11162.553497860157, 11174.10040293152, 11178.944105279421, 11179.496922638338, 18144.546386340182, 18266.26934922588, 18403.90798046001, 18404.815951840577, 18432.170552325177, 6687.0, 6977.51157418986, 7042.7887163385185, 7056.223815380304, 7091.184513780878, 785.7171418289525, 835.8202986357962, 869.0266901070842, 874.9693760718471, 1020.7703266764919, 27154.32114197161, 27512.0, 27513.587296190573, 27546.724532754415, 27563.310917226827, 928.3779867488798, 928.4150984879483, 929.0802105915095, 969.6121551379505, 988.0613417253494, 13572.524961626295, 14594.708105837824, 15082.396704131712, 15417.768733469007, 15424.151671658166, 324071.0, 329093.0, 330964.0, 331403.0, 332671.0, 48046.5195348049, 49301.506984930405, 49456.50543494591, 49572.50427495679, 49576.752116239186, 1136.4772204785727, 1204.6626944455566, 1207.8731733168242, 1208.4199584199635, 1270.980935285953, 24849.0, 25390.746092538837, 26682.19953401401, 27395.589066163626, 27552.724472755017, 40040.799796000836, 40458.0, 40763.38854917119, 40802.0, 40802.79598601988, 259605.0, 261609.0, 261755.0, 262811.0, 263733.0, 21274.893625531775, 21875.671864921722, 22832.429189270402, 23033.0, 23258.53482930366, 35108.64891351054, 35219.82390088033, 36440.27119457543, 36861.631383686894, 36953.44569831508, 32425.351492969538, 32644.183895402806, 32864.50703239405, 33105.33789324248, 33213.16967075843, 31566.684333156376, 33011.504827428085, 34491.0, 34668.13329666779, 35139.64860351364, 34316.0, 34921.47617785684, 34975.300493990486, 35036.94889153329, 35144.297114058085, 30042.948496802506, 31381.0, 31560.684393155774, 31691.84154079215, 31708.207294817814, 24238.757612424357, 24394.390140246636, 24408.63387049231, 24894.751052489242, 25002.499950001264], "value": 16740.920139793103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.7344022464163, 378.3530163420552, 379.4744279173346, 381.2013831024004, 385.64713287342084, 16158.091543522161, 16353.591160221, 16992.660146797058, 17042.147892605368, 17067.317307307694, 11791.292522448659, 15486.225688715576, 16289.83710162898, 16297.83702162978, 16304.83695163048, 4056.310427227371, 4839.9516004840025, 4862.343583616202, 4896.951030489703, 4897.8775530611665, 3423.263998240378, 5274.314339135907, 5554.833354999357, 5567.3040869891265, 5573.470520300585, 5469.617126801126, 5503.504684578387, 5513.917291240635, 5530.5022547970675, 5558.0, 5314.0700377433795, 5463.48096930791, 5467.398586155519, 5473.151661492475, 5474.206240095184, 3419.384510788057, 5117.181250999859, 5379.596530260207, 5382.1926710993275, 5395.5953303502, 11756.764864702744, 11766.294022358687, 11787.469563869647, 11900.404979750978, 12019.639410817603, 1895.1661269041579, 1936.0803618281345, 2109.9977510682456, 2388.713354397466, 2421.164698179143, 8849.292056635519, 9038.0, 9081.772955676095, 9270.768230794283, 9461.810763784686, 1697.8726595505264, 1704.2245778170902, 1739.8347157020062, 1746.7816522934634, 1754.491197552721, 67475.32524674789, 68310.65844670744, 69652.0, 70261.99999999949, 71249.0, 9939.155171810477, 9991.300608957303, 10045.598176072876, 10330.741731456623, 10539.525721342558, 13817.585472435843, 13916.234607096707, 13923.721525569432, 13944.790828137586, 13965.65085872841, 7029.929700702927, 7137.10786151731, 7175.282471752887, 7208.2791720828545, 7254.927450725425, 6683.0, 6748.4938629602975, 6783.932160678429, 6883.7590684325805, 6894.758683446055, 4247.320428731388, 4283.528811830696, 4288.356746488052, 4339.392485052095, 4405.118976204772, 1736.5571779196478, 1771.4419957713278, 1802.6935420978466, 1840.1811194018533, 1845.412944867413, 370.31676556752745, 390.5372134021194, 392.52308445239174, 400.9158076803904, 741.9740309089156, 9711.3202075854, 10081.899181008243, 10189.694309170736, 10203.979602039884, 10219.489025548693, 394.61525013111986, 402.60946881524876, 405.0420754914606, 409.0183559457267, 411.06482751739435, 5507.5593952483705, 5577.581681373832, 5593.105103183471, 5604.131359639263, 5705.515031222392, 334943.0, 336732.0, 340022.0, 359483.0, 360375.0, 74825.25174748183, 79319.20680793234, 79655.60172199101, 80164.0, 80292.0, 415.7817145998375, 417.13652738830933, 420.0800247458118, 420.268732405612, 423.5743078206383, 9308.301877359361, 9310.255438792301, 9480.241580673392, 9635.518224088908, 9708.805823883342, 31981.68018319787, 32170.126461465155, 32655.510167347034, 33023.0, 33218.33563328672, 48767.5123248763, 49358.25962610635, 49506.75246623888, 49658.503414966835, 49736.502634973185, 7570.735024274124, 7593.468457207942, 7769.339606133542, 7772.7668169954995, 8001.359891208573, 8328.3337333012, 10262.332948358333, 11380.260283081574, 11811.881881181078, 11849.874261945102, 9979.501024948579, 9998.300118991601, 10244.743881403025, 10249.12882405004, 10398.0, 10332.17342612574, 10375.0, 10380.117689996436, 10458.790824183627, 10575.576976921146, 9990.650327238513, 10397.896021039693, 10415.323004004715, 10585.364878107339, 10729.927007299208, 7466.887996680162, 7572.697092116254, 7641.579713115832, 7775.455718099905, 7786.922130778847, 9507.714768556954, 9818.361806482555, 9858.802823943624, 9914.851277230702, 10029.348092373972], "value": 7178.068363037568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.2656695832936, 1434.1896828292015, 1449.7752848308512, 1580.336258771316, 1745.9214335354907, 6603.801885943423, 7486.55080695158, 7653.885191722128, 7659.502132361393, 7675.846483070349, 7647.502912310696, 7799.025121859768, 7801.6489257983385, 7809.6485658145375, 7810.492317999326, 2204.669299605064, 2241.05875532276, 2244.0, 2246.853954492961, 2249.6175650139517, 2203.0747086223823, 2232.5646498932715, 2250.009995601938, 2252.245497758253, 2252.9436764080865, 2221.633430483976, 2234.8323875709307, 2236.888155592222, 2244.2706120510816, 2262.5814224368546, 2150.634392153322, 2173.1307477009163, 2183.7816218378193, 2187.759346471879, 2189.5183059726833, 2140.7538133114736, 2145.08833745659, 2148.581026699794, 2150.290404166621, 2152.7309086364203, 7545.7358992435, 7664.80837979055, 7732.729354472623, 7741.961290193569, 7799.415043871675, 4588.609968152711, 4732.1718699227495, 4736.313234580966, 4738.312944623045, 4738.312944623045, 2882.9855850720824, 2913.5192693205595, 2916.4458752836895, 2947.8083924544835, 2970.569267456207, 878.6529320918265, 879.445949052093, 886.561152229644, 895.3240303570827, 904.8280826642982, 10002.899971000343, 10388.324758890649, 10424.061834434937, 10424.426656533888, 10466.162706983423, 4017.5379831319774, 4078.530968938551, 4200.327947528381, 4201.810918508674, 4204.74771513704, 8223.588820558949, 8311.916880831235, 8343.249107580346, 8345.624446899905, 8352.498850069016, 4509.210888094636, 4601.562851529099, 4643.303504474288, 4650.581447669726, 4650.837220697259, 3751.0622344413896, 4072.714909956334, 4219.240536703423, 4235.724677895989, 4269.935950960738, 3405.250844814137, 3479.0780443182575, 3516.9648303516637, 3536.717062634983, 3538.133157376459, 1033.9069483746498, 1037.4708898461838, 1052.5105825791045, 1055.4458909072646, 1061.400308825511, 677.7560078371782, 775.9175949550346, 793.186983342079, 801.358912869702, 823.5840900345407, 4799.616030717534, 4817.325574419584, 4885.487023862514, 4937.259411088366, 4970.254461830755, 399.61037987961504, 406.93285607874367, 410.32296710427437, 411.80645096804454, 413.4769516561552, 3201.743860491155, 3307.6361600223954, 3610.945835812465, 3747.6252374762853, 3811.809409529568, 9211.40125891815, 9458.621655133718, 9674.22606191503, 9715.854262186072, 9742.07450292221, 9364.531773411301, 9587.856182157273, 9588.472634005057, 9625.470599116976, 9638.759031024281, 7234.782956511313, 7368.8894666580045, 7373.8156546086775, 7432.516886402366, 7460.477766556289, 5165.870853228699, 5246.42289348179, 5361.597880159082, 5409.459054094559, 5498.670079795225, 8015.198480151938, 8173.836523269621, 8260.83478330442, 8275.793105172419, 8666.393352465268, 8294.37792165578, 8302.916970830214, 8323.084460709197, 8374.204450577185, 8382.413231073766, 5706.629069110661, 6024.33732289439, 6158.538109641884, 6449.258335291502, 6632.767853125118, 6893.20728116273, 6923.480738944499, 6923.9307606923285, 6964.442844572321, 6975.511714179958, 5962.1951036611235, 6194.0, 6224.751009959551, 6336.398042185985, 6345.714442850175, 6130.2030736004035, 6173.351798061319, 6211.3167551570195, 6304.7162877671535, 6316.526260530387, 5471.370792358771, 5481.095619222943, 5524.033294173584, 5528.55771538284, 5530.198121272473, 4074.0, 4124.52567954689, 4135.069609337875, 4220.493540775126, 4238.957610423856, 4158.750474971512, 4240.893977650583, 4311.353297005474, 4358.3244597087505, 4370.235208838377], "value": 3922.5355865426673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.04660668444524, 310.65051816706205, 314.1815570439005, 314.8236987287119, 316.5599816255407, 4706.670533062683, 4747.715137091773, 4756.310335001427, 4778.283257511375, 4790.257510085934, 4682.648801339896, 4693.624510039197, 4705.85882423527, 4716.316134160553, 4736.100140973222, 3531.1348719563744, 3636.2545678136053, 3674.889753307405, 3759.4548790425374, 3767.2088861339153, 3709.1654377765058, 3739.4577786221116, 3743.251349730051, 3743.4010558310674, 3763.1156678180605, 3521.8415171317224, 3714.182879766447, 3722.143906901414, 3725.590185079639, 3733.5893051764283, 3576.8390422431053, 3699.648533389324, 3709.8330575124182, 3725.5529336479526, 3726.5341832270965, 3319.668033196685, 3320.734341252694, 3321.2029113012945, 3338.6327503974544, 3342.498625206214, 4497.865064048051, 4511.390962220091, 4514.255147900592, 4528.977355113237, 4533.637309015271, 3882.77692526856, 4192.559781222958, 4217.40956266123, 4224.302990006645, 4242.2576049191575, 4855.830045948375, 4937.259411088366, 4940.3330550375595, 4948.282499037619, 4964.280179373971, 3496.0, 3518.0, 3533.699635530983, 3537.2748586539697, 3541.3094446582927, 4977.875553111201, 5092.210707340369, 5115.872103197413, 5165.701262937994, 5176.7929282828645, 3590.8204589770407, 3600.8199590020395, 3602.8919132426067, 3608.9819550902075, 3620.8913732588067, 3645.4167333226555, 3651.904428671388, 3656.0, 3660.7254455915913, 3666.2218823870403, 4119.340905455113, 4129.91740165195, 4149.97925010373, 4164.5210800757695, 4174.791260437027, 4629.564834901192, 4923.655344125948, 4925.40895092584, 4956.107900577858, 4967.453580106186, 1320.9063634139804, 1331.1680199875077, 1334.9733005339838, 1335.4791631263815, 1336.8596297388829, 821.2649678537675, 875.1117615620151, 895.9328050396247, 913.6893456224915, 916.4694959417789, 4642.396488456479, 4649.697769644962, 4652.185867473178, 4654.185517534418, 4670.089332580114, 5376.973115134399, 5386.946130538723, 5391.460853914656, 5391.595630327741, 5393.892122157535, 4532.79602417892, 4637.582617564435, 4659.370984916993, 4676.532346765296, 4679.695819771704, 2836.9007084752348, 2873.827570345786, 2874.1664917173784, 2875.7699384049224, 2887.870045847942, 5069.619778516552, 5070.873228169326, 5075.137226671401, 5085.720285384339, 5097.974510127426, 5300.814471493479, 5442.0, 5454.290942177491, 5463.262459567907, 5498.945010549924, 5052.747362631927, 5054.0, 5067.290579318825, 5079.161938280143, 5086.779172998527, 5366.0, 5371.167469042305, 5378.946210538001, 5380.43505431924, 5386.407495175606, 5050.671706339076, 5241.947580524298, 5246.42289348179, 5256.027634887558, 5256.526912577886, 5015.774290157025, 5050.393952725696, 5058.797648094035, 5075.6193285502995, 5076.263941728503, 3779.7354185207873, 3780.6030366811087, 3784.3377408953875, 3786.905327366838, 3795.259924314732, 4853.902921941471, 5116.718580478109, 5127.5897928166405, 5131.820386286462, 5346.679199248058, 4945.159322915185, 4968.975155124346, 4969.552740253394, 4970.353853998957, 4987.625928055338, 4991.5258050485145, 4992.500749924979, 5014.648974571745, 5016.799328026984, 5017.297578339108, 4646.303054541846, 4776.641751868693, 4872.0, 4911.214205727067, 4927.0, 4867.610591152628, 4892.755362231946, 4902.730349830794, 4910.8281210157475, 4937.28409380645, 4757.14371413149, 4867.610591152628, 4877.707337559757, 4902.411710594752, 4918.843577177279], "value": 3812.325770629307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.8625302433464, 685.0, 730.8172956760811, 764.762923493717, 775.7207405334078, 11958.7608247835, 12079.879201207985, 12162.878371216308, 12163.635090947264, 12284.508619655215, 11776.057915366771, 11854.170208085437, 11897.34564598949, 11906.880931190686, 11943.730691168672, 635.965021923794, 760.0992823504165, 782.5695867272991, 794.4796158516181, 799.8200404908907, 791.6833266693311, 792.6591565626778, 799.2766546275601, 799.6361655446758, 799.9160088190744, 829.274384913201, 836.0719601242616, 837.1210229259253, 837.5728378526934, 838.1953324808192, 662.3939095727428, 801.9839603207903, 833.1085738260064, 835.2941764209294, 835.908050114487, 613.3069631316629, 616.1189499016405, 616.3990109643062, 617.718937883262, 618.0482057631242, 11552.59565915189, 11596.652100437, 11603.477843496978, 11611.6516504505, 11629.185956983014, 11691.123165762601, 12123.636290911287, 12582.0, 12620.621381358575, 12832.422540985677, 9943.90056099437, 9948.602055917754, 9987.450690212036, 10351.58593656253, 10403.739906502322, 3240.7893486923276, 3331.783434076777, 3353.7088221034833, 3372.5615669962995, 3434.21013166973, 44834.0, 45128.323075153574, 45382.773086134686, 45521.317180242324, 45609.0, 9340.953295233616, 9700.951495242478, 9735.756606084904, 9816.509174541245, 9959.601615935426, 16962.66074678524, 16966.660666786596, 16968.74546881798, 16995.40516081931, 17012.979221246766, 6273.8745225095245, 6341.397567231105, 6501.31736167705, 6710.362515561014, 6734.0, 3604.351216780952, 3623.655752703489, 3672.6694597486353, 3708.4437334400054, 3762.059485128718, 2752.7384898435016, 2810.2131403207136, 2810.578413238031, 2811.2269125990515, 2815.352468932157, 475.4033687721887, 487.51979300389087, 490.5143907531518, 493.4473389803443, 499.3757802746567, 496.34234639103335, 587.2835141127817, 602.3223873142714, 614.2352770800383, 618.7215752911208, 7292.270772922771, 7441.800155598543, 7614.5575920249985, 7675.692972281046, 7692.153863075057, 529.2854646227639, 536.3322663284158, 538.9218563308299, 550.5210466893748, 559.400115669194, 3689.7232707546505, 3691.4647376130847, 3715.8142092895787, 3717.2565486902727, 3750.774953502744, 47204.29193562099, 50945.23582146271, 52780.73609631927, 53890.73054634702, 54016.45983540114, 45401.31898021532, 46641.766791166505, 47644.28533571999, 47664.0, 48157.75921120372, 43519.34720979188, 43593.56406435895, 43989.78005110018, 44276.77861610671, 44511.55488445074, 6998.475114366341, 7074.610896400747, 7143.357097861218, 7265.200827909031, 7398.704051838082, 29704.851475742482, 30009.0, 30030.0, 30168.54747178838, 30222.0, 35053.824730877204, 35982.28035439224, 37694.62305376911, 37793.81103094467, 38255.808720956215, 9553.331266811256, 9762.60949562038, 10029.498525073863, 10033.598656053677, 10162.0, 10433.373997560171, 10713.732156696145, 10795.460226988462, 11329.830052549383, 11490.138239631893, 9926.335358033984, 10140.188784897044, 10148.64479743235, 10661.0, 11016.228863979444, 10701.304415212986, 10824.596764209315, 11399.145064120059, 11400.315981041163, 11768.0, 10230.335028223142, 10565.577376904837, 10925.781484370427, 10950.233483656068, 11290.15323850698, 8897.555122243992, 9070.455772653662, 9110.407823491452, 9303.906960930304, 9558.904410955802, 8576.742697719079, 8626.137386261324, 8936.151065648754, 9135.817283654156, 9176.174144326775], "value": 5773.137507017415, "unit": "score"}], "name": "dromaeo_css", "value": 6027.596017332351, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 108.0, 112.0, 114.0, 113.0, 103.0, 115.0, 111.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 134.0, 154.0, 189.0, 132.0, 158.0, 158.0, 133.0, 187.0, 140.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 174.0, 165.0, 164.0, 164.0, 161.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 104.0, 114.0, 77.0, 74.0, 77.0, 117.0, 105.0, 75.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 144.0, 95.0, 94.0, 93.0, 147.0, 94.0, 94.0, 146.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 68.0, 66.0, 81.0, 64.0, 76.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 63.0, 63.0, 64.0, 64.0, 70.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 77.0, 80.0, 80.0, 88.0, 81.0, 79.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 128.0, 128.0, 127.0, 127.0, 142.0, 129.0, 210.0, 132.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 172.0, 174.0, 179.0, 175.0, 173.0, 173.0, 183.0, 175.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 72.0, 76.0, 70.0, 69.0, 72.0, 72.0, 70.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1585.9000000000003, "alertThreshold": 2.0}]} 07:16:14 INFO - Return code: 0 07:16:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:16:14 ERROR - # TBPL SUCCESS # 07:16:14 INFO - Running post-action listener: _resource_record_post_action 07:16:14 INFO - Running post-run listener: _resource_record_post_run 07:16:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 478490624; Read time: 20; Write time: 339664 07:16:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 195108864; Read time: 0; Write time: 195504 07:16:15 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283381760; Read time: 20; Write time: 144160 07:16:15 INFO - Running post-run listener: _upload_blobber_files 07:16:15 INFO - Blob upload gear active. 07:16:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:16:15 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 07:16:15 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'] 07:16:15 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 07:16:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:16 INFO - (blobuploader) - INFO - Done attempting. 07:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:17 INFO - (blobuploader) - INFO - Done attempting. 07:16:17 INFO - (blobuploader) - INFO - Iteration through files over. 07:16:17 INFO - Return code: 0 07:16:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:16:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:16:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae35ee43e063d36699ba80997ed0de3505ca2a78523d1c6b3ee1e546e247427ced32dc38f9214c99d5c54069751dfe1dd3639efe8c64027eaae234bdfd06281b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aceea786a61d674def36e6db7d84ec731449c2654b8df4fb37217ce3d62cc81c9420397dc1c3de4d1834da5ee8e79bf5c1f3679adf1b34ac03e4c3ed6201312b"} 07:16:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:16:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:16:17 INFO - Contents: 07:16:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae35ee43e063d36699ba80997ed0de3505ca2a78523d1c6b3ee1e546e247427ced32dc38f9214c99d5c54069751dfe1dd3639efe8c64027eaae234bdfd06281b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aceea786a61d674def36e6db7d84ec731449c2654b8df4fb37217ce3d62cc81c9420397dc1c3de4d1834da5ee8e79bf5c1f3679adf1b34ac03e4c3ed6201312b"} 07:16:17 INFO - Running post-run listener: copy_logs_to_upload_dir 07:16:17 INFO - Copying logs to upload dir... 07:16:17 INFO - mkdir: /builds/slave/test/build/upload/logs 07:16:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.695163 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-25 07:16:17.326442) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:17.330439) ========= 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=cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453 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/ae35ee43e063d36699ba80997ed0de3505ca2a78523d1c6b3ee1e546e247427ced32dc38f9214c99d5c54069751dfe1dd3639efe8c64027eaae234bdfd06281b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aceea786a61d674def36e6db7d84ec731449c2654b8df4fb37217ce3d62cc81c9420397dc1c3de4d1834da5ee8e79bf5c1f3679adf1b34ac03e4c3ed6201312b"} build_url:https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/TPbN3eR3QO-n0u256hZeAg/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/ae35ee43e063d36699ba80997ed0de3505ca2a78523d1c6b3ee1e546e247427ced32dc38f9214c99d5c54069751dfe1dd3639efe8c64027eaae234bdfd06281b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aceea786a61d674def36e6db7d84ec731449c2654b8df4fb37217ce3d62cc81c9420397dc1c3de4d1834da5ee8e79bf5c1f3679adf1b34ac03e4c3ed6201312b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:17.355403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:17.355760) ========= 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=cbe409c6de289db6ac707de3000001d4-1461588768.443437-1410083453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:16:17.441129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:16:17.441473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:16:17.441792) ========= ========= Total master_lag: 0.19 =========