builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1462874860.8 results: success (0) buildid: 20160510023217 builduid: fd7bb5f2090448d7aee97f0ec9b8f060 revision: 553a9575ad40687f2a5486b1170de0ae8a280015 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:40.804853) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:40.805286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:40.805565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:40.816605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:40.816917) ========= 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=1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 03:07:41-- 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% 100M=0s 2016-05-10 03:07:41 (100 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.395906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.223574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.223900) ========= 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=1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009633 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.271721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.272281) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 553a9575ad40687f2a5486b1170de0ae8a280015 --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 553a9575ad40687f2a5486b1170de0ae8a280015 --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=1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 03:07:41,999 truncating revision to first 12 chars 2016-05-10 03:07:41,999 Setting DEBUG logging. 2016-05-10 03:07:41,999 attempt 1/10 2016-05-10 03:07:41,999 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/553a9575ad40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 03:07:42,248 unpacking tar archive at: fx-team-553a9575ad40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.482014 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.762852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.763180) ========= script_repo_revision: 553a9575ad40687f2a5486b1170de0ae8a280015 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.763570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.763843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 03:07:41.769966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-10 03:07:41.770364) ========= /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=1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:07:42 INFO - MultiFileLogger online at 20160510 03:07:42 in /builds/slave/test 03:07:42 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 03:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:07:42 INFO - {'append_to_log': False, 03:07:42 INFO - 'base_work_dir': '/builds/slave/test', 03:07:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:07:42 INFO - 'branch': 'Fx-Team-Non-PGO', 03:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 03:07:42 INFO - 'config_files': ('talos/linux_config.py',), 03:07:42 INFO - 'default_actions': ('clobber', 03:07:42 INFO - 'read-buildbot-config', 03:07:42 INFO - 'download-and-extract', 03:07:42 INFO - 'populate-webroot', 03:07:42 INFO - 'create-virtualenv', 03:07:42 INFO - 'install', 03:07:42 INFO - 'run-tests'), 03:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:07:42 INFO - 'download_minidump_stackwalk': True, 03:07:42 INFO - 'download_symbols': 'ondemand', 03:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 03:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 03:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:07:42 INFO - 'installer_path': 'installer.exe', 03:07:42 INFO - 'log_level': 'info', 03:07:42 INFO - 'log_name': 'talos', 03:07:42 INFO - 'log_to_console': True, 03:07:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:07:42 INFO - 'opt_config_files': (), 03:07:42 INFO - 'pip_index': False, 03:07:42 INFO - 'sps_profile': False, 03:07:42 INFO - 'sps_profile_interval': 0, 03:07:42 INFO - 'suite': 'dromaeojs', 03:07:42 INFO - 'system_bits': '32', 03:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:07:42 INFO - 'title': 'talos-linux64-ix-027', 03:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:07:42 INFO - 'use_talos_json': True, 03:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:07:42 INFO - 'work_dir': 'build'} 03:07:42 INFO - ##### 03:07:42 INFO - ##### Running clobber step. 03:07:42 INFO - ##### 03:07:42 INFO - Running pre-action listener: _resource_record_pre_action 03:07:42 INFO - Running main action method: clobber 03:07:42 INFO - rmtree: /builds/slave/test/build 03:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:07:43 INFO - Running post-action listener: _resource_record_post_action 03:07:43 INFO - ##### 03:07:43 INFO - ##### Finished clobber step (success) 03:07:43 INFO - ##### 03:07:43 INFO - ##### 03:07:43 INFO - ##### Running read-buildbot-config step. 03:07:43 INFO - ##### 03:07:43 INFO - Running pre-action listener: _resource_record_pre_action 03:07:43 INFO - Running main action method: read_buildbot_config 03:07:43 INFO - Using buildbot properties: 03:07:43 INFO - { 03:07:43 INFO - "project": "", 03:07:43 INFO - "product": "firefox", 03:07:43 INFO - "script_repo_revision": "production", 03:07:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:07:43 INFO - "repository": "", 03:07:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:07:43 INFO - "buildid": "20160510023217", 03:07:43 INFO - "pgo_build": "False", 03:07:43 INFO - "basedir": "/builds/slave/test", 03:07:43 INFO - "buildnumber": 2946, 03:07:43 INFO - "slavename": "talos-linux64-ix-027", 03:07:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:07:43 INFO - "platform": "ubuntu64_hw", 03:07:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:07:43 INFO - "branch": "fx-team", 03:07:43 INFO - "repo_path": "integration/fx-team", 03:07:43 INFO - "revision": "553a9575ad40687f2a5486b1170de0ae8a280015", 03:07:43 INFO - "stage_platform": "linux64", 03:07:43 INFO - "builduid": "fd7bb5f2090448d7aee97f0ec9b8f060", 03:07:43 INFO - "slavebuilddir": "test" 03:07:43 INFO - } 03:07:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:07:43 INFO - Running post-action listener: _resource_record_post_action 03:07:43 INFO - ##### 03:07:43 INFO - ##### Finished read-buildbot-config step (success) 03:07:43 INFO - ##### 03:07:43 INFO - ##### 03:07:43 INFO - ##### Running download-and-extract step. 03:07:43 INFO - ##### 03:07:43 INFO - Running pre-action listener: _resource_record_pre_action 03:07:43 INFO - Running main action method: download_and_extract 03:07:43 INFO - mkdir: /builds/slave/test/build/tests 03:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:43 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:07:46 INFO - Downloaded 1361 bytes. 03:07:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:07:46 INFO - Using the following test package requirements: 03:07:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:07:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:07:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:07:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'jsshell-linux-x86_64.zip'], 03:07:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:07:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:07:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:07:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:07:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:07:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:07:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:07:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:07: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')]} 03:07:46 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:07:48 INFO - Downloaded 22323319 bytes. 03:07:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:07:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:07:49 INFO - Return code: 0 03:07:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:49 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:07:53 INFO - Downloaded 22323319 bytes. 03:07:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:07:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:07:54 INFO - Return code: 0 03:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:07:54 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:07:55 INFO - Downloaded 10840152 bytes. 03:07:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:07:56 INFO - Return code: 0 03:07:56 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')]} 03:07:56 INFO - https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:07:57 INFO - Downloaded 54861467 bytes. 03:07:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:07:57 INFO - mkdir: /builds/slave/test/properties 03:07:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:07:57 INFO - Writing to file /builds/slave/test/properties/build_url 03:07:57 INFO - Contents: 03:07:57 INFO - build_url:https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:07:58 INFO - Running post-action listener: _resource_record_post_action 03:07:58 INFO - Running post-action listener: set_extra_try_arguments 03:07:58 INFO - ##### 03:07:58 INFO - ##### Finished download-and-extract step (success) 03:07:58 INFO - ##### 03:07:58 INFO - ##### 03:07:58 INFO - ##### Running populate-webroot step. 03:07:58 INFO - ##### 03:07:58 INFO - Running pre-action listener: _resource_record_pre_action 03:07:58 INFO - Running main action method: populate_webroot 03:07:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:07:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:07:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:07:58 INFO - '--tppagecycles', 03:07:58 INFO - '7'], 03:07:58 INFO - 'tests': ['tsvgm']}}, 03:07:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:07:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:07:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:07:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:07:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:07:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['damp', 'tps']}, 03:07:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'tests': ['damp', 'tps']}, 03:07:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['dromaeo_dom']}, 03:07:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:07:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['a11yr', 03:07:58 INFO - 'ts_paint', 03:07:58 INFO - 'tpaint', 03:07:58 INFO - 'sessionrestore', 03:07:58 INFO - 'sessionrestore_no_auto_restore', 03:07:58 INFO - 'tabpaint']}, 03:07:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:07:58 INFO - 'ts_paint', 03:07:58 INFO - 'tpaint', 03:07:58 INFO - 'sessionrestore', 03:07:58 INFO - 'sessionrestore_no_auto_restore', 03:07:58 INFO - 'tabpaint']}, 03:07:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:07:58 INFO - 'ts_paint', 03:07:58 INFO - 'tpaint', 03:07:58 INFO - 'sessionrestore', 03:07:58 INFO - 'sessionrestore_no_auto_restore', 03:07:58 INFO - 'tabpaint']}, 03:07:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:07:58 INFO - 'ts_paint', 03:07:58 INFO - 'tpaint', 03:07:58 INFO - 'sessionrestore', 03:07:58 INFO - 'sessionrestore_no_auto_restore', 03:07:58 INFO - 'tabpaint']}, 03:07:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['a11yr', 03:07:58 INFO - 'ts_paint', 03:07:58 INFO - 'tpaint', 03:07:58 INFO - 'sessionrestore', 03:07:58 INFO - 'sessionrestore_no_auto_restore', 03:07:58 INFO - 'tabpaint']}, 03:07:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['a11yr', 03:07:58 INFO - 'ts_paint', 03:07:58 INFO - 'tpaint', 03:07:58 INFO - 'sessionrestore', 03:07:58 INFO - 'sessionrestore_no_auto_restore', 03:07:58 INFO - 'tabpaint']}, 03:07:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['tsvgx', 03:07:58 INFO - 'tsvgr_opacity', 03:07:58 INFO - 'tart', 03:07:58 INFO - 'tscrollx', 03:07:58 INFO - 'cart']}, 03:07:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:07:58 INFO - 'tsvgr_opacity', 03:07:58 INFO - 'tart', 03:07:58 INFO - 'tscrollx', 03:07:58 INFO - 'cart']}, 03:07:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'talos_options': ['--disable-e10s'], 03:07:58 INFO - 'tests': ['tp5o']}, 03:07:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'tests': ['tp5o']}, 03:07:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'talos_options': ['--disable-e10s', 03:07:58 INFO - '--xperf_path', 03:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:58 INFO - 'tests': ['tp5n']}, 03:07:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:07:58 INFO - 'talos_options': ['--xperf_path', 03:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:07:58 INFO - 'tests': ['tp5n']}}, 03:07:58 INFO - 'talos.zip': {'path': '', 03:07:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:07:58 INFO - Running post-action listener: _resource_record_post_action 03:07:58 INFO - ##### 03:07:58 INFO - ##### Finished populate-webroot step (success) 03:07:58 INFO - ##### 03:07:58 INFO - ##### 03:07:58 INFO - ##### Running create-virtualenv step. 03:07:58 INFO - ##### 03:07:58 INFO - Running pre-action listener: _resource_record_pre_action 03:07:58 INFO - Running main action method: create_virtualenv 03:07:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:07:58 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 03:07:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:07:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:07:58 INFO - Using real prefix '/usr' 03:07:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:07:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:01 INFO - Installing pip.................done. 03:08:01 INFO - Return code: 0 03:08:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:01 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:01 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 03:08:01 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 03:08:01 INFO - Using env: {'DISPLAY': ':0', 03:08:01 INFO - 'HOME': '/home/cltbld', 03:08:01 INFO - 'LANG': 'en_US.UTF-8', 03:08:01 INFO - 'LANGUAGE': 'en_US:en', 03:08:01 INFO - 'LOGNAME': 'cltbld', 03:08:01 INFO - 'MAIL': '/var/mail/cltbld', 03:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:01 INFO - 'MOZ_NO_REMOTE': '1', 03:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:01 INFO - 'NO_EM_RESTART': '1', 03:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:01 INFO - 'PWD': '/builds/slave/test', 03:08:01 INFO - 'SHELL': '/bin/bash', 03:08:01 INFO - 'SHLVL': '1', 03:08:01 INFO - 'TERM': 'linux', 03:08:01 INFO - 'TMOUT': '86400', 03:08:01 INFO - 'USER': 'cltbld', 03:08:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:01 INFO - '_': '/tools/buildbot/bin/python'} 03:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:01 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 03:08:01 INFO - Cleaning up... 03:08:01 INFO - Return code: 0 03:08:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:01 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:01 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 03:08:01 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 03:08:01 INFO - Using env: {'DISPLAY': ':0', 03:08:01 INFO - 'HOME': '/home/cltbld', 03:08:01 INFO - 'LANG': 'en_US.UTF-8', 03:08:01 INFO - 'LANGUAGE': 'en_US:en', 03:08:01 INFO - 'LOGNAME': 'cltbld', 03:08:01 INFO - 'MAIL': '/var/mail/cltbld', 03:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:01 INFO - 'MOZ_NO_REMOTE': '1', 03:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:01 INFO - 'NO_EM_RESTART': '1', 03:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:01 INFO - 'PWD': '/builds/slave/test', 03:08:01 INFO - 'SHELL': '/bin/bash', 03:08:01 INFO - 'SHLVL': '1', 03:08:01 INFO - 'TERM': 'linux', 03:08:01 INFO - 'TMOUT': '86400', 03:08:01 INFO - 'USER': 'cltbld', 03:08:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:01 INFO - '_': '/tools/buildbot/bin/python'} 03:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:01 INFO - Downloading/unpacking psutil>=0.7.1 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 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 03:08:01 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 03:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:05 INFO - Installing collected packages: psutil 03:08:05 INFO - Running setup.py install for psutil 03:08:05 INFO - building 'psutil._psutil_linux' extension 03:08:05 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 03:08:05 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 03:08:05 INFO - building 'psutil._psutil_posix' extension 03:08:05 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 03:08:05 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 03:08:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:06 INFO - Successfully installed psutil 03:08:06 INFO - Cleaning up... 03:08:06 INFO - Return code: 0 03:08:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:08:06 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')]} 03:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:06 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')]} 03:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:06 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:06 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 03:08:06 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 03:08:06 INFO - Using env: {'DISPLAY': ':0', 03:08:06 INFO - 'HOME': '/home/cltbld', 03:08:06 INFO - 'LANG': 'en_US.UTF-8', 03:08:06 INFO - 'LANGUAGE': 'en_US:en', 03:08:06 INFO - 'LOGNAME': 'cltbld', 03:08:06 INFO - 'MAIL': '/var/mail/cltbld', 03:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:06 INFO - 'MOZ_NO_REMOTE': '1', 03:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:06 INFO - 'NO_EM_RESTART': '1', 03:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:06 INFO - 'PWD': '/builds/slave/test', 03:08:06 INFO - 'SHELL': '/bin/bash', 03:08:06 INFO - 'SHLVL': '1', 03:08:06 INFO - 'TERM': 'linux', 03:08:06 INFO - 'TMOUT': '86400', 03:08:06 INFO - 'USER': 'cltbld', 03:08:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:06 INFO - '_': '/tools/buildbot/bin/python'} 03:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:08:09 INFO - Installing collected packages: mozsystemmonitor 03:08:09 INFO - Running setup.py install for mozsystemmonitor 03:08:09 INFO - Successfully installed mozsystemmonitor 03:08:09 INFO - Cleaning up... 03:08:09 INFO - Return code: 0 03:08:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:08:09 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')]} 03:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:09 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')]} 03:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:09 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:09 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 03:08:09 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 03:08:09 INFO - Using env: {'DISPLAY': ':0', 03:08:09 INFO - 'HOME': '/home/cltbld', 03:08:09 INFO - 'LANG': 'en_US.UTF-8', 03:08:09 INFO - 'LANGUAGE': 'en_US:en', 03:08:09 INFO - 'LOGNAME': 'cltbld', 03:08:09 INFO - 'MAIL': '/var/mail/cltbld', 03:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:09 INFO - 'MOZ_NO_REMOTE': '1', 03:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:09 INFO - 'NO_EM_RESTART': '1', 03:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:09 INFO - 'PWD': '/builds/slave/test', 03:08:09 INFO - 'SHELL': '/bin/bash', 03:08:09 INFO - 'SHLVL': '1', 03:08:09 INFO - 'TERM': 'linux', 03:08:09 INFO - 'TMOUT': '86400', 03:08:09 INFO - 'USER': 'cltbld', 03:08:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:09 INFO - '_': '/tools/buildbot/bin/python'} 03:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08:15 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 03:08:15 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 03:08:15 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 03:08:15 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 03:08:15 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 03:08:15 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 03:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:08:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08:17 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 03:08:17 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 03:08:17 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 03:08:17 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 03:08:17 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 03:08:17 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 03:08:18 INFO - Downloading docopt-0.6.1.tar.gz 03:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:18 INFO - Running setup.py install for blobuploader 03:08:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:08:18 INFO - Running setup.py install for requests 03:08:18 INFO - Running setup.py install for docopt 03:08:18 INFO - Successfully installed blobuploader requests docopt 03:08:18 INFO - Cleaning up... 03:08:18 INFO - Return code: 0 03:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:18 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:18 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 03:08:18 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 03:08:18 INFO - Using env: {'DISPLAY': ':0', 03:08:18 INFO - 'HOME': '/home/cltbld', 03:08:18 INFO - 'LANG': 'en_US.UTF-8', 03:08:18 INFO - 'LANGUAGE': 'en_US:en', 03:08:18 INFO - 'LOGNAME': 'cltbld', 03:08:18 INFO - 'MAIL': '/var/mail/cltbld', 03:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:18 INFO - 'MOZ_NO_REMOTE': '1', 03:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:18 INFO - 'NO_EM_RESTART': '1', 03:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:18 INFO - 'PWD': '/builds/slave/test', 03:08:18 INFO - 'SHELL': '/bin/bash', 03:08:18 INFO - 'SHLVL': '1', 03:08:18 INFO - 'TERM': 'linux', 03:08:18 INFO - 'TMOUT': '86400', 03:08:18 INFO - 'USER': 'cltbld', 03:08:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:18 INFO - '_': '/tools/buildbot/bin/python'} 03:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:19 INFO - Running setup.py (path:/tmp/pip-EuATZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:19 INFO - Running setup.py (path:/tmp/pip-w1EmaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:19 INFO - Running setup.py (path:/tmp/pip-1c8bGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:19 INFO - Running setup.py (path:/tmp/pip-zyIuqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:19 INFO - Running setup.py (path:/tmp/pip-QlQ3zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:19 INFO - Running setup.py (path:/tmp/pip-5Vu4sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:19 INFO - Running setup.py (path:/tmp/pip-WtVia_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:19 INFO - Running setup.py (path:/tmp/pip-ohhh3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:19 INFO - Running setup.py (path:/tmp/pip-4EJG8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:19 INFO - Running setup.py (path:/tmp/pip-IAkonF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:19 INFO - Running setup.py (path:/tmp/pip-NdhbbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:19 INFO - Running setup.py (path:/tmp/pip-xRjfGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:19 INFO - Running setup.py (path:/tmp/pip-qtDi2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:19 INFO - Running setup.py (path:/tmp/pip-Lp7d0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:19 INFO - Running setup.py (path:/tmp/pip-gtn5my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:19 INFO - Running setup.py (path:/tmp/pip-Dt1Fw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:20 INFO - Running setup.py (path:/tmp/pip-5k2Awz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:20 INFO - Running setup.py install for manifestparser 03:08:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Running setup.py install for mozcrash 03:08:20 INFO - Running setup.py install for mozdebug 03:08:20 INFO - Running setup.py install for mozdevice 03:08:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Running setup.py install for mozfile 03:08:20 INFO - Running setup.py install for mozhttpd 03:08:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Running setup.py install for mozinfo 03:08:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Running setup.py install for mozInstall 03:08:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:08:20 INFO - Running setup.py install for mozleak 03:08:20 INFO - Running setup.py install for mozlog 03:08:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Running setup.py install for moznetwork 03:08:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Running setup.py install for mozprocess 03:08:21 INFO - Running setup.py install for mozprofile 03:08:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Running setup.py install for mozrunner 03:08:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Running setup.py install for mozscreenshot 03:08:21 INFO - Running setup.py install for moztest 03:08:21 INFO - Running setup.py install for mozversion 03:08:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:08:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:21 INFO - Cleaning up... 03:08:21 INFO - Return code: 0 03:08:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:21 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')]} 03:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:21 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')]} 03:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:21 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:21 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 03:08:21 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 03:08:21 INFO - Using env: {'DISPLAY': ':0', 03:08:21 INFO - 'HOME': '/home/cltbld', 03:08:21 INFO - 'LANG': 'en_US.UTF-8', 03:08:21 INFO - 'LANGUAGE': 'en_US:en', 03:08:21 INFO - 'LOGNAME': 'cltbld', 03:08:21 INFO - 'MAIL': '/var/mail/cltbld', 03:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:21 INFO - 'MOZ_NO_REMOTE': '1', 03:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:21 INFO - 'NO_EM_RESTART': '1', 03:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:21 INFO - 'PWD': '/builds/slave/test', 03:08:21 INFO - 'SHELL': '/bin/bash', 03:08:21 INFO - 'SHLVL': '1', 03:08:21 INFO - 'TERM': 'linux', 03:08:21 INFO - 'TMOUT': '86400', 03:08:21 INFO - 'USER': 'cltbld', 03:08:21 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:21 INFO - '_': '/tools/buildbot/bin/python'} 03:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:21 INFO - Running setup.py (path:/tmp/pip-PFzX3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:21 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)) 03:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:21 INFO - Running setup.py (path:/tmp/pip-bAGv5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:22 INFO - Running setup.py (path:/tmp/pip-EVpU8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:22 INFO - Running setup.py (path:/tmp/pip-pzvCS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:22 INFO - Running setup.py (path:/tmp/pip-pCy_D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:22 INFO - Running setup.py (path:/tmp/pip-S3Xq_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:22 INFO - Running setup.py (path:/tmp/pip-kYZY5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:22 INFO - Running setup.py (path:/tmp/pip-deYpT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:22 INFO - Running setup.py (path:/tmp/pip-oCdUov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:22 INFO - Running setup.py (path:/tmp/pip-VUb9UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:22 INFO - Running setup.py (path:/tmp/pip-gdrdpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:22 INFO - Running setup.py (path:/tmp/pip-3QCOd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:22 INFO - Running setup.py (path:/tmp/pip-BESNyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:22 INFO - Running setup.py (path:/tmp/pip-veKDud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:22 INFO - Running setup.py (path:/tmp/pip-1k0EPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:22 INFO - Running setup.py (path:/tmp/pip-92W4Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:22 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)) 03:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:22 INFO - Running setup.py (path:/tmp/pip-KE01Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:22 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)) 03:08:22 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)) 03:08:22 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)) 03:08:22 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)) 03:08:22 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)) 03:08:22 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)) 03:08:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:22 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 03:08:22 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 03:08:22 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 03:08:22 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 03:08:22 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 03:08:22 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 03:08:26 INFO - Downloading blessings-1.6.tar.gz 03:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:26 INFO - Installing collected packages: blessings 03:08:26 INFO - Running setup.py install for blessings 03:08:26 INFO - Successfully installed blessings 03:08:26 INFO - Cleaning up... 03:08:27 INFO - Return code: 0 03:08:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:08:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:27 INFO - Reading from file tmpfile_stdout 03:08:27 INFO - Current package versions: 03:08:27 INFO - argparse == 1.2.1 03:08:27 INFO - blessings == 1.6 03:08:27 INFO - blobuploader == 1.2.4 03:08:27 INFO - docopt == 0.6.1 03:08:27 INFO - manifestparser == 1.1 03:08:27 INFO - mozInstall == 1.12 03:08:27 INFO - mozcrash == 0.17 03:08:27 INFO - mozdebug == 0.1 03:08:27 INFO - mozdevice == 0.48 03:08:27 INFO - mozfile == 1.2 03:08:27 INFO - mozhttpd == 0.7 03:08:27 INFO - mozinfo == 0.9 03:08:27 INFO - mozleak == 0.1 03:08:27 INFO - mozlog == 3.1 03:08:27 INFO - moznetwork == 0.27 03:08:27 INFO - mozprocess == 0.22 03:08:27 INFO - mozprofile == 0.28 03:08:27 INFO - mozrunner == 6.11 03:08:27 INFO - mozscreenshot == 0.1 03:08:27 INFO - mozsystemmonitor == 0.0 03:08:27 INFO - moztest == 0.7 03:08:27 INFO - mozversion == 1.4 03:08:27 INFO - psutil == 3.1.1 03:08:27 INFO - requests == 1.2.3 03:08:27 INFO - wsgiref == 0.1.2 03:08:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:27 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')]} 03:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:27 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')]} 03:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:27 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:27 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 03:08:27 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 03:08:27 INFO - Using env: {'DISPLAY': ':0', 03:08:27 INFO - 'HOME': '/home/cltbld', 03:08:27 INFO - 'LANG': 'en_US.UTF-8', 03:08:27 INFO - 'LANGUAGE': 'en_US:en', 03:08:27 INFO - 'LOGNAME': 'cltbld', 03:08:27 INFO - 'MAIL': '/var/mail/cltbld', 03:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:27 INFO - 'MOZ_NO_REMOTE': '1', 03:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:27 INFO - 'NO_EM_RESTART': '1', 03:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:27 INFO - 'PWD': '/builds/slave/test', 03:08:27 INFO - 'SHELL': '/bin/bash', 03:08:27 INFO - 'SHLVL': '1', 03:08:27 INFO - 'TERM': 'linux', 03:08:27 INFO - 'TMOUT': '86400', 03:08:27 INFO - 'USER': 'cltbld', 03:08:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:27 INFO - '_': '/tools/buildbot/bin/python'} 03:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 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)) 03:08:27 INFO - Cleaning up... 03:08:27 INFO - Return code: 0 03:08:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08:27 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')]} 03:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:27 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')]} 03:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:27 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:27 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 03:08:27 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 03:08:27 INFO - Using env: {'DISPLAY': ':0', 03:08:27 INFO - 'HOME': '/home/cltbld', 03:08:27 INFO - 'LANG': 'en_US.UTF-8', 03:08:27 INFO - 'LANGUAGE': 'en_US:en', 03:08:27 INFO - 'LOGNAME': 'cltbld', 03:08:27 INFO - 'MAIL': '/var/mail/cltbld', 03:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:27 INFO - 'MOZ_NO_REMOTE': '1', 03:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:27 INFO - 'NO_EM_RESTART': '1', 03:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:27 INFO - 'PWD': '/builds/slave/test', 03:08:27 INFO - 'SHELL': '/bin/bash', 03:08:27 INFO - 'SHLVL': '1', 03:08:27 INFO - 'TERM': 'linux', 03:08:27 INFO - 'TMOUT': '86400', 03:08:27 INFO - 'USER': 'cltbld', 03:08:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:27 INFO - '_': '/tools/buildbot/bin/python'} 03:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:27 INFO - Downloading/unpacking jsonschema 03:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:08:34 INFO - Downloading/unpacking functools32 (from jsonschema) 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:08:34 INFO - warning: no files found matching '*.txt' 03:08:34 INFO - no previously-included directories found matching 'build' 03:08:34 INFO - no previously-included directories found matching 'dist' 03:08:34 INFO - no previously-included directories found matching '.git*' 03:08:34 INFO - Installing collected packages: jsonschema, functools32 03:08:34 INFO - Running setup.py install for functools32 03:08:34 INFO - warning: no files found matching '*.txt' 03:08:34 INFO - no previously-included directories found matching 'build' 03:08:34 INFO - no previously-included directories found matching 'dist' 03:08:34 INFO - no previously-included directories found matching '.git*' 03:08:34 INFO - Successfully installed jsonschema functools32 03:08:34 INFO - Cleaning up... 03:08:34 INFO - Return code: 0 03:08:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:08:34 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')]} 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:34 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')]} 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:34 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 0x7f1f3d7d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, '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': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', '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 03:08:34 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 03:08:34 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 03:08:34 INFO - Using env: {'DISPLAY': ':0', 03:08:34 INFO - 'HOME': '/home/cltbld', 03:08:34 INFO - 'LANG': 'en_US.UTF-8', 03:08:34 INFO - 'LANGUAGE': 'en_US:en', 03:08:34 INFO - 'LOGNAME': 'cltbld', 03:08:34 INFO - 'MAIL': '/var/mail/cltbld', 03:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:34 INFO - 'MOZ_NO_REMOTE': '1', 03:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:34 INFO - 'NO_EM_RESTART': '1', 03:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:34 INFO - 'PWD': '/builds/slave/test', 03:08:34 INFO - 'SHELL': '/bin/bash', 03:08:34 INFO - 'SHLVL': '1', 03:08:34 INFO - 'TERM': 'linux', 03:08:34 INFO - 'TMOUT': '86400', 03:08:34 INFO - 'USER': 'cltbld', 03:08:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:34 INFO - '_': '/tools/buildbot/bin/python'} 03:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:34 INFO - Downloading/unpacking flake8 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:08:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:08:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 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 03:08:44 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 03:08:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:08:46 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 03:08:46 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 03:08:46 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 03:08:46 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 03:08:46 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 03:08:46 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 03:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:47 INFO - no previously-included directories found matching 'docs/_build' 03:08:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:08:48 INFO - Running setup.py install for pep8 03:08:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:48 INFO - no previously-included directories found matching 'docs/_build' 03:08:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:08:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:08:48 INFO - Cleaning up... 03:08:48 INFO - Return code: 0 03:08:48 INFO - Running post-action listener: _resource_record_post_action 03:08:48 INFO - Running post-action listener: _start_resource_monitoring 03:08:48 INFO - Starting resource monitoring. 03:08:48 INFO - ##### 03:08:48 INFO - ##### Finished create-virtualenv step (success) 03:08:48 INFO - ##### 03:08:48 INFO - ##### 03:08:48 INFO - ##### Running install step. 03:08:48 INFO - ##### 03:08:48 INFO - Running pre-action listener: _resource_record_pre_action 03:08:48 INFO - Running main action method: install 03:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:48 INFO - Reading from file tmpfile_stdout 03:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:48 INFO - Reading from file tmpfile_stdout 03:08:48 INFO - Output received: 03:08:48 INFO - Usage: mozinstall [options] installer 03:08:48 INFO - Options: 03:08:48 INFO - -h, --help show this help message and exit 03:08:48 INFO - -d DEST, --destination=DEST 03:08:48 INFO - Directory to install application into. [default: 03:08:48 INFO - "/builds/slave/test"] 03:08:48 INFO - --app=APP Application being installed. [default: firefox] 03:08:48 INFO - mkdir: /builds/slave/test/build/application 03:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:09:04 INFO - Reading from file tmpfile_stdout 03:09:04 INFO - Output received: 03:09:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:09:04 INFO - Running post-action listener: _resource_record_post_action 03:09:04 INFO - ##### 03:09:04 INFO - ##### Finished install step (success) 03:09:04 INFO - ##### 03:09:04 INFO - ##### 03:09:04 INFO - ##### Running run-tests step. 03:09:04 INFO - ##### 03:09:04 INFO - Running pre-action listener: _resource_record_pre_action 03:09:04 INFO - Running main action method: run_tests 03:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:04 INFO - Python 2.7.3 03:09:04 INFO - Return code: 0 03:09:04 INFO - grabbing minidump binary from tooltool 03:09: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')]} 03:09:04 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 0x24879c0>, '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 0x24888c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2488d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:04 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 03:09:04 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 03:09:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:04 INFO - Return code: 0 03:09:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:09:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:09:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:09:05 INFO - Return code: 0 03:09:05 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/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:09:05 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/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 03:09:05 INFO - Using env: {'DISPLAY': ':0', 03:09:05 INFO - 'HOME': '/home/cltbld', 03:09:05 INFO - 'LANG': 'en_US.UTF-8', 03:09:05 INFO - 'LANGUAGE': 'en_US:en', 03:09:05 INFO - 'LOGNAME': 'cltbld', 03:09:05 INFO - 'MAIL': '/var/mail/cltbld', 03:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:05 INFO - 'MOZ_NO_REMOTE': '1', 03:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:05 INFO - 'NO_EM_RESTART': '1', 03:09:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:05 INFO - 'PWD': '/builds/slave/test', 03:09:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:05 INFO - 'SHELL': '/bin/bash', 03:09:05 INFO - 'SHLVL': '1', 03:09:05 INFO - 'TERM': 'linux', 03:09:05 INFO - 'TMOUT': '86400', 03:09:05 INFO - 'USER': 'cltbld', 03:09:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256', 03:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:05 INFO - '_': '/tools/buildbot/bin/python'} 03:09:05 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/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 03:09:05 INFO - mozversion application_buildid: 20160510023217 03:09:05 INFO - mozversion application_changeset: 553a9575ad40687f2a5486b1170de0ae8a280015 03:09:05 INFO - mozversion application_display_name: Nightly 03:09:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:05 INFO - mozversion application_name: Firefox 03:09:05 INFO - mozversion application_remotingname: firefox 03:09:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:09:05 INFO - mozversion application_vendor: Mozilla 03:09:05 INFO - mozversion application_version: 49.0a1 03:09:05 INFO - mozversion platform_buildid: 20160510023217 03:09:05 INFO - mozversion platform_changeset: 553a9575ad40687f2a5486b1170de0ae8a280015 03:09:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:09:05 INFO - mozversion platform_version: 49.0a1 03:09:05 INFO - using testdate: 1462874945 03:09:05 INFO - actual date: 1462874945 03:09:05 INFO - starting webserver on 'localhost:43564' 03:09:05 INFO - SUITE-START | Running 2 tests 03:09:05 INFO - TEST-START | dromaeo_css 03:09:05 INFO - operating with platform_type : linux_ 03:09:05 INFO - Initialising browser for dromaeo_css test... 03:09:05 INFO - TEST-INFO | started process 24671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9bH0f/profile http://localhost:43564/getInfo.html) 03:09:09 INFO - PROCESS | 24671 | __metrics Screen width/height:1600/1200 03:09:09 INFO - PROCESS | 24671 | colorDepth:24 03:09:09 INFO - PROCESS | 24671 | Browser inner width/height: 1024/697 03:09:09 INFO - PROCESS | 24671 | __metrics 03:09:10 ERROR - PROCESS | 24671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:09:10 INFO - TEST-INFO | 24671: exit 0 03:09:10 INFO - Browser initialized. 03:09:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:09:10 INFO - TEST-INFO | started process 24751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9bH0f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:22 INFO - PROCESS | 24751 | RSS: Main: 153190400 03:09:22 INFO - PROCESS | 24751 | 03:10:13 INFO - PROCESS | 24751 | 1462875013966 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] 03:12:25 INFO - PROCESS | 24751 | Cycle 1(1): loaded http://localhost:43564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43564/tests/dromaeo/cssquery-ext.html) 03:12:26 INFO - PROCESS | 24751 | RSS: Main: 239554560 03:12:26 INFO - PROCESS | 24751 | 03:15:28 INFO - PROCESS | 24751 | Cycle 1(1): loaded http://localhost:43564/tests/dromaeo/cssquery-ext.html (next: http://localhost:43564/tests/dromaeo/cssquery-jquery.html) 03:15:29 INFO - PROCESS | 24751 | RSS: Main: 234434560 03:15:29 INFO - PROCESS | 24751 | 03:18:31 INFO - PROCESS | 24751 | Cycle 1(1): loaded http://localhost:43564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43564/tests/dromaeo/cssquery-mootools.html) 03:18:31 INFO - PROCESS | 24751 | RSS: Main: 241582080 03:18:31 INFO - PROCESS | 24751 | 03:21:33 INFO - PROCESS | 24751 | Cycle 1(1): loaded http://localhost:43564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43564/tests/dromaeo/cssquery-prototype.html) 03:21:34 INFO - PROCESS | 24751 | RSS: Main: 233013248 03:21:34 INFO - PROCESS | 24751 | 03:24:37 INFO - PROCESS | 24751 | Cycle 1(1): loaded http://localhost:43564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43564/tests/dromaeo/cssquery-yui.html) 03:24:38 INFO - PROCESS | 24751 | RSS: Main: 201748480 03:24:38 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | Cycle 1(1): loaded http://localhost:43564/tests/dromaeo/cssquery-yui.html (next: http://localhost:43564/tests/dromaeo/cssquery-dojo.html) 03:27:40 INFO - PROCESS | 24751 | RSS: Main: 269565952 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | __start_tp_report 03:27:40 INFO - PROCESS | 24751 | _x_x_mozilla_page_load 03:27:40 INFO - PROCESS | 24751 | _x_x_mozilla_page_load_details 03:27:40 INFO - PROCESS | 24751 | |i|pagename|runs| 03:27:40 INFO - PROCESS | 24751 | |0;dojo.html;2634.6970098438687;2636.222314417247;2663.3874208931943;2670.893164273429;2676.2238950704295;4558.6581006424485;4579.542045795419;4629.814807407708;4650.813967441299;4710.057988402316;4587.495375508692;4624.653151013671;4672.229082201433;4684.344191813149;4725.432948046231;4215.578442155791;4217.240896638611;4289.9356509652225;4352.434183556134;4491.281394976804;4352.368906508555;4384.0355121873135;4410.140022695576;4412.029353542232;4429.136318417894;4183.288840897025;4195.454590903194;4211.410402543646;4214.7681877496725;4288.76411797351;4285.550017248175;4299.290617048183;4344.56554344563;4354.368616550582;4358.6730995175485;4349.478062632473;4360.89097772555;4360.934585981213;4371.388005679208;4422.823087076513;4470.128324976631;4581.129585378767;4614.469336026366;4628.3288923105965;4700.918788678623;5069.721165335905;5086.3133476980875;5087.414947281036;5125.513076257786;5145.228215767627;4872.269159626049;5066.06277838601;5091.847244582668;5114.744262786883;5151.562117220041;4655.068986202739;4666.0901124280435;4687.531246875354;4721.126591580569;4733.692309999839;5078.085944529947;5167.767450464738;5172.069027574998;5195.116830138885;5199.610029247746;4840.104580652591;4933.4819843915875;5040.621953353513;5058.861756104847;5072.949270507322;5010.348654674869;5049.192129259301;5098.031374038921;5112.284280200774;5122.743862806845;5011.749412529359;5036.992601479718;5042.991401719597;5053.267276244924;5102.107131252016;4786.617070634341;4880.975595122072;4905.23968784839;5034.874128146826;5053.267276244924;4248.256555102845;4257.957420425818;4275.615194632498;4275.978620106879;4279.33670281107;3655.2324011957785;3705.7035437164964;3710.4990826238113;3730.850765969385;3737.5328083989502;4102.733322334038;4140.4617399737845;4219.936700949488;4235.30117530604;4263.552327005682;5037.5214354636255;5062.898742025139;5076.010178015325;5085.338905942203;5123.897522049539;4288.927768057985;4290.549492303326;4330.545292744279;4330.631896288788;4334.50153232376;4081.6122468365456;4407.581279778416;4489.506154323022;4559.452865656076;4579.931301030487;4707.599854012447;4722.433308003062;4725.149473094876;4739.265413860857;4800.279958006327;5001.549860512571;5018.971110922179;5031.723255220998;5045.041442125985;5047.671901326402;4531.003179300548;4726.527347265246;4737.739424331695;4764.737939413366;4780.330753694555;4950.851474455772;4984.252362145708;5013.423456302426;5017.197248440232;5034.421041580265;4879.829205977774;4935.185694360391;4954.727489988085;4963.9327544576645;5013.523715247045;4836.709797412166;4883.633727470383;4917.213245880642;4920.581750551243;4937.456879743298;4916.434610019751;4929.482404347492;4955.058538877602;4968.826091086795;5003.924941125959;4661.720296782204;4696.084263568571;4726.810927562997;4875.268709693574;4882.36529251195;4887.095887260868;4897.436794768647;4899.583535399531;4905.950940490549;4974.676646017997;4787.832425865078;4828.66199366041;4829.179039563212;4830.7826147824135;4868.90262194747 03:27:40 INFO - PROCESS | 24751 | |1;ext.html;528.5322489596708;558.8100045984365;569.8917205730913;577.3360635269438;598.9101634754788;28540.286492837662;31617.84191079044;31837.52243716346;39840;40668;37924.62075379246;41789.37315940263;42275;42423.818213633946;42751.78624106883;7941.523508589488;8000.359971202319;8034;8068.515889046646;8072.878906816402;7784.922150778476;7908.44640875139;7929.484583502054;7935.603219838985;7959.482633628824;7936.920630793676;7946.125926148119;7974.760757177294;8014.639341229658;8018.67925282988;7902.802429939269;7918.1290058093855;7928.6035698214855;7930.881036784453;7932.286094251545;7856.450048496607;7889.487183333065;7904.644291006918;7925.603719814044;7950.880736788953;39506.60493395087;39925;39927.80036099801;40006.1994110559;40104.59895401067;3231.1275955491888;3323.4350160472777;3338.2488939988552;3372.881949131793;3732.9626703733156;28614.713852861412;28625.14124576266;29033.37082864642;29133.12600621985;29208.123756287347;3153.4323821712082;3191.1419835544853;3200.9199770005703;3203.7116659500757;3301.240714635623;175382;176506;176507;177673;246760.29859551942;47601.52398475971;47815;48013.75993120082;48070.75964620154;48307.516924831005;34886.30227395438;35811.28377432489;35836;36647.633523664954;36825.07937301535;14423;14636.04865683727;14657.04729192599;14681.77977330341;14748.483803066842;11000.954909283766;11088.611898583511;11093.168012399103;11115.610953616746;11152.721181970515;18678.719819202724;18684.906575467037;18710.81289187118;18723.81276187248;18810.717839232424;7321.853562928818;7336.156342020736;7414.962925185448;7433.8141546461775;7462.925370746331;868.8566386546149;920.4845286639503;924.9815003699888;998.4209158687944;1016.7305663999047;27373.589396159074;28490.433026183346;28648.570271445944;29028.564571531442;29031.564526532118;925.2274350916925;1009.4750729620556;1015.1929216272933;1018.8217062014118;1039.7868436970402;15035.398584056735;15225.923870380577;15319.846801532065;15333.531864204751;15360.84639153594;374006;375686;376873;377862;377922;48523.5147648526;49428.50571494311;49590.75204623954;49808.50191498111;49920.750396247786;1150.3040660400504;1231.3289257354763;1265.1523479268913;1281.442572480955;1283.0120806978762;27732.168034958984;28738.425231495672;29219.042858927904;29275;29707.257318566346;41804;41929.161416772105;42621;42672.57327426686;42713.35929960991;292678;294508;294621;296359;296703;22673;25108;25327.36681582975;25845.612315814902;27100.32249193786;41533.37699934564;41860.58139418567;41882.58117418909;42626;42700.78649606856;36374;36407.08982275464;36954.63045369512;36997;37207.81396093002;34413.65586344105;37214;37368.62631373652;37976.81011594924;38245.80877095708;36485.63514364822;37000.07499812418;37154;37390.62609373871;38391.808040960736;31657.36858518999;33888.15279618029;34156.82921585376;34360.14099647529;34525.65474345224;25437.491250175262;25989.6101558473;25997.350066248495;26000.8699956499;26024.34939126537 03:27:40 INFO - PROCESS | 24751 | |2;jquery.html;372.68508110646496;374.94375843623453;384.50398985308954;395.08537735143125;401.6385253272057;16579.83420165798;17126.571835704115;17669.64660706785;17888.731669024975;17913.37303194387;16659.83340166598;16895.91552042241;17466.301347946068;17583.032933188668;17761.82238177618;4984.999999999991;5179.482051794828;5202.479752024786;5212.817551385702;5220.973895130519;3619.5294611700574;5139.869228769665;5896.23348964634;5913.024350982083;5999.370066143036;5926.1110833374905;5944.583879128462;5945.435183657567;5950.404959504058;5978.8804223915495;5707.914381284284;5821.912671309934;5878.5003274721275;5910;5937.732802023897;4890.902181956341;5091.847244582668;5120.436751957282;5138.100832354323;5152.665076770036;21267.5746485071;21310.254141105142;21518.139274429002;21549.784502154933;21590.568188636298;1983.623111608804;1990.6914428263642;2045.6420126477806;2296;2306.815454763615;12030.759384812342;13250.66873328165;13364.264965426995;13501.527446539323;13889;1756.929722811086;1794.883332583378;1808.5659441734022;1829.570051038005;1890.3100368365585;62265.6886715568;64380.678096609685;66032.33967660357;66145.3385466144;66431;9598.42409455435;9619.038096190325;9691.660791872391;9702.805943881083;9764.121229089416;12725.809112863315;12741.936290318488;12838.42227099764;12844.779745924123;12869;7442.739504117439;7485;7502.512336698097;7627.970224019798;7662.808429789188;7289.635518224173;7326.780196594111;7358.153812311546;7451.627418629047;7455.813604659818;6145.385461453909;6266.060090986389;6277.748890044347;6307.274663413767;6366.790309841208;1642.2199455258656;1711.922963466647;1739.8347157020062;1748.825117488241;1750.6323672028761;893.3523195683077;966.8501382285757;969.9951500242454;987.2200961240683;1034.7288296860067;16570.254338554794;17253.341597768784;17264.827351726322;17695.646087078185;17761.111944402728;898.5058217980085;931.7204838548544;941.6327632223438;946.4652471353663;951.2485136742034;9673.758156046015;10249.9487502562;10283.28017038815;10396.740081498023;10495.947520262349;394622;413475;427977;430794;432023;68280.31719682839;69039;69426;69556;69871.30128698648;978.1392374710209;1008.3496144986443;1019.9694009179736;1020.433659319085;1025.9281850270409;15284.235788210768;15639;15679;15731.21343932776;16028.358865645243;32690.182745431553;33126.503102453;33168.83415582906;33719.15702107369;34008.48987265144;44492.77753611211;44652.77673611741;44694.55305446904;44699.32951005803;44808.103837922405;7668.961655191688;7703.961480192564;7737.3036426721865;7771.378289736695;7797.844043119219;11676.416179191176;11754.11844111678;11788.410579470821;11899.821502677294;12091.69770755703;10252.64115755945;10258.53836577341;10456.63401780934;10489.47552622381;10499.527521261409;10033.1973442123;10117.89882101199;10179.440130792878;10554.419506926886;10581.100606448537;10159.796804064024;10193.439360835226;10385.740356491147;10469.214808889212;10852.023317901427;7465.7013719450615;7622;7720.420968427503;8065.798355041171;8077.071136819341;10145.594176232868;10298.330608510723;10312.896871031193;10617.681469555926;10711.625093121704 03:27:40 INFO - PROCESS | 24751 | |3;mootools.html;1263.2546797389539;1453.367785013519;1490.0091439192934;1653.222985196957;1855.999999999999;7006.929930700691;7384.150822655396;7391.445641576883;7574;7580.204078571754;7338.3395494405495;7523.699052037912;7538.472306938516;7552.169261381244;7552.207018263086;1850.5188650950784;2134.253011445997;2196.626573482508;2220.356096731954;2239.1603148819195;2262.6492893601435;2262.9660555091687;2266.7506574276817;2271.5684020036224;2278.487340348425;2139.8181154601875;2140.4541841830387;2163.6321825289738;2172.630652789022;2177.2162021672184;1746.5022468596453;2065.10168076887;2118.5868755592664;2145.442185031887;2151.171798857451;2130.4141361125658;2135.4234356723755;2161.654135338338;2164.0694501364405;2165.1123039553863;7364.963175184143;7431.628418579049;7437.590932498711;7452.552846829153;7454;4388.2539968205165;4550.067236216568;4573.977130114361;4576.702514336557;4589.380433641482;2902.6661933877663;2965.4810408178696;2982.567527708492;3005.443992861328;3026.2585666511627;900.8333458310168;941.7410212191634;943.7263193673826;949.1647350331733;955.7849483866144;9920.355176913477;9937.10566049059;9975.650852220137;9979.351342162809;10008.94995525025;3920.2159568086495;4005.379166229239;4056.269871423172;4066.064805094845;4092.3656833190903;8468.745937621881;8564.571771411529;8568.485890846445;8583;8584.098669639598;4468.798904049326;4560.224761790503;4562.68061235717;4577.267637178035;4592.219322715079;3584.713222942158;4062.1266427718183;4101.569335219759;4188.057687020457;4208.179405015992;3524.101354154674;3563.572371315459;3607.1703508193264;3659.597444281127;3712.888613341604;1161.7095726068483;1162.84301619282;1163.831244469547;1171.0807016492013;1180.0972256223995;837.6984285657159;844.0335815491351;911.2800887299092;912;912.6258234123977;5091.465396133427;5157.174852023733;5162.109481557137;5188.610854185951;5290.047791397586;896.8654701794652;906.5286051253312;915.0986278515657;938.9530523473799;943.8018016216671;3612.2414292998237;3710.109573702346;3751.324761542894;3756.6806821419937;3763.8870833875026;8786.780330491789;9100.772480687903;9214.861777073349;9235.584398702074;9254.35219534626;8728.781780455412;8963.507007114671;9088.272938165062;9208.539573021322;9218.078192180863;7031.29687031303;7045.295470453017;7118.359347658632;7155.964220178866;7169.426445884316;4878.9512104878495;4942.159832828356;4981.6014718823135;5320.920186197132;5327.547158491417;8398.202170793766;8576.399652024547;8581.95709021451;8700.78248043804;8703.86944195825;7780.183080776437;8273.83452330938;8281.461704989157;8708.78228044304;8723.345749068973;5505.229267902577;6193.566450348432;6289.622622642656;6363.331850155852;6586.407223349922;7253.782386528413;7292.854142917005;7339.59632220233;7345.926540734525;7367.042284502981;6518.608883466817;6671.39957403836;6719.563228390139;6762;6816.965915170393;6453.741850326122;6464.353564643498;6490.350964903472;6517.315681853337;6551.377619126175;6116.17431646722;6184.752609895554;6200.875982480235;6205.100260462298;6223.782167624111;4256.553061928576;4475.5300693426725;4505.166544189336;4507.368968344369;4522.140793249272;4642.16441040616;4687.296905464208;4687.648426368104;4713.410823647044;4738.50245724194 03:27:40 INFO - PROCESS | 24751 | |4;prototype.html;302.7381315162385;306.94321550513155;312.58738465225906;317.6156850211247;318.2457575545956;4631.536846315366;4646.744429056401;4649.976750116253;4650.860474185772;4726.66913316068;4535.954640453603;4541.65937554683;4570.611498022664;4597.954020459794;4600.42494688164;3457.308538292339;3558.946615800765;3583.5878873929573;3674.0814796300924;3688.4467329900463;3642.3990041643096;3667.2848794484953;3677.5035370224946;3677.926441471169;3702.426123950792;3605.3149901518627;3620.1311685195496;3628.219932714466;3634.218642991756;3641.5083963664965;3436.415809312423;3493.6681015303634;3622.2212224371888;3641.635836416337;3655.323765103464;3245;3245.799054349882;3248.6842828654435;3274.836258187105;3277.918052048694;4329.653627709808;4340.197063543223;4368.148211098837;4378.452693413324;4396.934045989313;3981.7212795104356;4094.856680016215;4117.402976568411;4120.773357465338;4141.565135660742;4754.833580824655;4766.094442055998;4766.547178018082;4775.068861571995;4776.6116941529235;3551.911202219965;3563.3407819553468;3571.6428357164336;3575;3578.910527236814;4962.975185124087;4973.62697797663;4980.078685443204;4989.5758860496535;4994.051130285234;3442.7590068695454;3616.8734094306574;3632.20091579852;3669.94495082574;3674.81625918703;3704.073981504624;3705.7591256568235;3708.1841994761107;3713.350163721338;3713.665770080706;4125.876223713293;4126.174765047002;4126.339785634284;4135;4148.709590328708;4595.586397224199;4758.262469317261;4817.253325734517;4819.397575303087;4823.686460380064;1222.2544248008708;1228.7726770547476;1240.1009268280425;1240.6712221261193;1242.8508578970582;835.6699103853944;837.7151768398774;838.8196537744415;867.5358683104508;884.8186121845135;3907;3911.5501717302304;4122.958770412258;4226.936595951063;4230.767307798101;4976.62675299354;5002.224655178453;5027.748612569357;5032.974835125801;5035.546800787946;4172.144710334374;4247.851325203603;4289.978550107292;4304.440422745023;4307.763073031013;2512.2212114244644;2552.5405427023315;2555.9744402556107;2562.7181010088875;2562.769350758441;4489.5959363656775;4523.819047238139;4545.568171023748;4575.130725162208;4575.519570445122;4893.853184404403;4921.572743904299;4922.212446008622;4952.108620448282;4955.975220123876;4376.824927002885;4709.788059537329;4713.976430117896;4721.527847215389;4735.644826637947;4935.185694360391;4946.802127914843;4970.826021089245;5020.4979502050965;5043.646944713835;4879.4388645304825;4891.951080489292;4901.828436004723;4904.803807847647;4921.680090794087;4391.8682439526865;4629.166749985035;4678.7308155545215;4694.671373003994;4702.553257440538;3598.172420343283;3642.8360723766964;3653.1597732521136;3688.428293614494;3701.5188025556504;4927.334809800775;4938.333325001223;4963.503649635008;4974.129527332775;4992.800287988585;4555.339475775928;4838.371011768448;4839.516048395132;4853.174960256694;4853.223484242504;4769.689970151929;4778.761061946958;4798.73606951621;4808.831690890942;4819.879503012453;4747.531283732509;4772.379590653193;4792.185328494234;4795.376601041842;4801.399825021872;4537.296719008559;4571.1543364477675;4827.782749776339;4844.539768721966;4846.5638092571835;4701.22429799093;4741.193997020446;4765.571098601143;4770.356001939694;4793.209120495079 03:27:40 INFO - PROCESS | 24751 | |5;yui.html;738.641758747008;763.6067425275982;787.322902304018;788.1291173253559;797.6689673785379;10348.741281467966;11121.777564448716;11244.212905096647;11324.094072474214;11335.886641133586;12221.816672749894;12265.448054837532;12282.57011004615;12285.14004019719;12409.503619855195;650.6519012328405;832.546262287055;842.389267780857;857.0401150711212;865.4850364033422;858.6393714639835;862.5557837713583;863.8531449653574;864.1056506515757;865.0657290126649;923.2890674180877;923.7505873414174;923.8383282925495;924.7549399409128;925.3753716241511;689.3726708695089;879.3229213505597;899.6851102114273;904.7602385367883;910.5947853205327;674.0664180110533;676.6954870308381;676.864627074587;677.6273049822578;678.2471456683078;11046.668599942015;11070.612528561462;11085.944570277177;11107.888921110767;11138.49876755548;11440.71398215043;11718.648440546796;11967.341796201206;12587.874121258761;12595.496180152782;8810.735677929672;10092.293539452241;10578.735531611694;10921.344719316867;10929.672109836718;4140.5282196124945;4184.916301673949;4302.139572085595;4322.654187664979;4335.306350983859;40289.19421611552;40575.18849622991;40848.387274190914;40916.79541602303;40947;9985.550650220757;10076.546555405024;10133.493325333704;10373.170146388271;10874.891251087545;17026.489205323862;17034.659306813795;17053.062081585384;17072.829271707124;17106.91446542759;6012.609180403259;6076.118962750376;6131.662758548234;6509.609423434609;6551.705173267214;3415.743819213519;3429.3655673700446;3472.3055388922317;3486.5816102067915;3494.8951531454095;2832.2919270182456;2920.8685609147637;2933.9706602934125;2947.6904924982996;2949.7640188785276;537.1110811606796;537.1566640374652;537.2290762755458;542.9945700543024;546.0471477272185;474.0779184486141;475.177942160065;522.4723029739914;543.565147881701;558.3606770248043;7501.849963000709;7546.735864244725;7674.808129796688;7710.498817576839;7806.1413244543055;580.5964854426218;583.3262581718122;597.5757212379173;615.796787060269;620.5066971757374;3263.543103965447;3540.946885796715;3579.5167652367118;3612.385894397906;3641.7450778445786;48502.5149748498;48606.75696621565;48805.511944880804;49390.75304623526;49556;45026.54973450289;45063;45123.548764511936;45239.321410178876;45905.7704711481;40578.391324129574;40594.391084133764;40927.59072409238;41255;41567.58432415637;6953.826154346182;7014.473914456538;7058.505904586835;7118.750843720445;7134.571925684476;26792.33019174536;27349.726502734717;28016.439671206055;28391.716082838906;28605.141845743827;33773.493397599545;35496.82251588725;36153.45769813402;36312.63687363092;37162.814185928895;9075.27397808187;9159.371269399018;9205.907940920504;9301.953490232505;9371.765705857408;9351.485668288038;9609.951950240204;9666.854997175189;9865.26010549226;10003.899961000297;8995.505247211466;8997.595108220277;9036.096390360912;9138.588763505792;9702.563384647849;8672.609732562176;8744.781380465285;9030.548472576213;9297;9313.208377288007;9211.907880921373;9254.629814807333;9302;9350.53247337644;9350.81298374015;7794.844103118019;7957.363410926996;8068.556229407439;8238.176182381954;8253.257206851413;7649.847003060019;7847.882281765664;7950.324222440926;8106.9189308108525;8344.624491897757 03:27:40 INFO - PROCESS | 24751 | __end_tp_report 03:27:40 INFO - PROCESS | 24751 | __start_cc_report 03:27:40 INFO - PROCESS | 24751 | _x_x_mozilla_cycle_collect,792 03:27:40 INFO - PROCESS | 24751 | __end_cc_report 03:27:40 INFO - PROCESS | 24751 | __startTimestamp1462876060829__endTimestamp 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | ------- Summary: start ------- 03:27:40 INFO - PROCESS | 24751 | Number of tests: 6 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | [#0] dojo.html Cycles:165 Average:4636.70 Median:4733.69 stddev:495.08 (10.5%) stddev-sans-first:471.03 03:27:40 INFO - PROCESS | 24751 | Values: 2634.7 2636.2 2663.4 2670.9 2676.2 4558.7 4579.5 4629.8 4650.8 4710.1 4587.5 4624.7 4672.2 4684.3 4725.4 4215.6 4217.2 4289.9 4352.4 4491.3 4352.4 4384.0 4410.1 4412.0 4429.1 4183.3 4195.5 4211.4 4214.8 4288.8 4285.6 4299.3 4344.6 4354.4 4358.7 4349.5 4360.9 4360.9 4371.4 4422.8 4470.1 4581.1 4614.5 4628.3 4700.9 5069.7 5086.3 5087.4 5125.5 5145.2 4872.3 5066.1 5091.8 5114.7 5151.6 4655.1 4666.1 4687.5 4721.1 4733.7 5078.1 5167.8 5172.1 5195.1 5199.6 4840.1 4933.5 5040.6 5058.9 5072.9 5010.3 5049.2 5098.0 5112.3 5122.7 5011.7 5037.0 5043.0 5053.3 5102.1 4786.6 4881.0 4905.2 5034.9 5053.3 4248.3 4258.0 4275.6 4276.0 4279.3 3655.2 3705.7 3710.5 3730.9 3737.5 4102.7 4140.5 4219.9 4235.3 4263.6 5037.5 5062.9 5076.0 5085.3 5123.9 4288.9 4290.5 4330.5 4330.6 4334.5 4081.6 4407.6 4489.5 4559.5 4579.9 4707.6 4722.4 4725.1 4739.3 4800.3 5001.5 5019.0 5031.7 5045.0 5047.7 4531.0 4726.5 4737.7 4764.7 4780.3 4950.9 4984.3 5013.4 5017.2 5034.4 4879.8 4935.2 4954.7 4963.9 5013.5 4836.7 4883.6 4917.2 4920.6 4937.5 4916.4 4929.5 4955.1 4968.8 5003.9 4661.7 4696.1 4726.8 4875.3 4882.4 4887.1 4897.4 4899.6 4906.0 4974.7 4787.8 4828.7 4829.2 4830.8 4868.9 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | [#1] ext.html Cycles:180 Average:44311.65 Median:36889.85 stddev:78332.13 (212.3%) stddev-sans-first:78482.89 03:27:40 INFO - PROCESS | 24751 | Values: 528.5 558.8 569.9 577.3 598.9 28540.3 31617.8 31837.5 39840.0 40668.0 37924.6 41789.4 42275.0 42423.8 42751.8 7941.5 8000.4 8034.0 8068.5 8072.9 7784.9 7908.4 7929.5 7935.6 7959.5 7936.9 7946.1 7974.8 8014.6 8018.7 7902.8 7918.1 7928.6 7930.9 7932.3 7856.5 7889.5 7904.6 7925.6 7950.9 39506.6 39925.0 39927.8 40006.2 40104.6 3231.1 3323.4 3338.2 3372.9 3733.0 28614.7 28625.1 29033.4 29133.1 29208.1 3153.4 3191.1 3200.9 3203.7 3301.2 175382.0 176506.0 176507.0 177673.0 246760.3 47601.5 47815.0 48013.8 48070.8 48307.5 34886.3 35811.3 35836.0 36647.6 36825.1 14423.0 14636.0 14657.0 14681.8 14748.5 11001.0 11088.6 11093.2 11115.6 11152.7 18678.7 18684.9 18710.8 18723.8 18810.7 7321.9 7336.2 7415.0 7433.8 7462.9 868.9 920.5 925.0 998.4 1016.7 27373.6 28490.4 28648.6 29028.6 29031.6 925.2 1009.5 1015.2 1018.8 1039.8 15035.4 15225.9 15319.8 15333.5 15360.8 374006.0 375686.0 376873.0 377862.0 377922.0 48523.5 49428.5 49590.8 49808.5 49920.8 1150.3 1231.3 1265.2 1281.4 1283.0 27732.2 28738.4 29219.0 29275.0 29707.3 41804.0 41929.2 42621.0 42672.6 42713.4 292678.0 294508.0 294621.0 296359.0 296703.0 22673.0 25108.0 25327.4 25845.6 27100.3 41533.4 41860.6 41882.6 42626.0 42700.8 36374.0 36407.1 36954.6 36997.0 37207.8 34413.7 37214.0 37368.6 37976.8 38245.8 36485.6 37000.1 37154.0 37390.6 38391.8 31657.4 33888.2 34156.8 34360.1 34525.7 25437.5 25989.6 25997.4 26000.9 26024.3 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | [#2] jquery.html Cycles:180 Average:24819.67 Median:373.81 stddev:68814.21 (18408.7%) stddev-sans-first:68982.77 03:27:40 INFO - PROCESS | 24751 | Values: 372.7 374.9 384.5 395.1 401.6 16579.8 17126.6 17669.6 17888.7 17913.4 16659.8 16895.9 17466.3 17583.0 17761.8 4985.0 5179.5 5202.5 5212.8 5221.0 3619.5 5139.9 5896.2 5913.0 5999.4 5926.1 5944.6 5945.4 5950.4 5978.9 5707.9 5821.9 5878.5 5910.0 5937.7 4890.9 5091.8 5120.4 5138.1 5152.7 21267.6 21310.3 21518.1 21549.8 21590.6 1983.6 1990.7 2045.6 2296.0 2306.8 12030.8 13250.7 13364.3 13501.5 13889.0 1756.9 1794.9 1808.6 1829.6 1890.3 62265.7 64380.7 66032.3 66145.3 66431.0 9598.4 9619.0 9691.7 9702.8 9764.1 12725.8 12741.9 12838.4 12844.8 12869.0 7442.7 7485.0 7502.5 7628.0 7662.8 7289.6 7326.8 7358.2 7451.6 7455.8 6145.4 6266.1 6277.7 6307.3 6366.8 1642.2 1711.9 1739.8 1748.8 1750.6 893.4 966.9 970.0 987.2 1034.7 16570.3 17253.3 17264.8 17695.6 17761.1 898.5 931.7 941.6 946.5 951.2 9673.8 10249.9 10283.3 10396.7 10495.9 394622.0 413475.0 427977.0 430794.0 432023.0 68280.3 69039.0 69426.0 69556.0 69871.3 978.1 1008.3 1020.0 1020.4 1025.9 15284.2 15639.0 15679.0 15731.2 16028.4 32690.2 33126.5 33168.8 33719.2 34008.5 44492.8 44652.8 44694.6 44699.3 44808.1 7669.0 7704.0 7737.3 7771.4 7797.8 11676.4 11754.1 11788.4 11899.8 12091.7 10252.6 10258.5 10456.6 10489.5 10499.5 10033.2 10117.9 10179.4 10554.4 10581.1 10159.8 10193.4 10385.7 10469.2 10852.0 7465.7 7622.0 7720.4 8065.8 8077.1 10145.6 10298.3 10312.9 10617.7 10711.6 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | [#3] mootools.html Cycles:180 Average:4972.37 Median:5416.39 stddev:2687.87 (49.6%) stddev-sans-first:2680.95 03:27:40 INFO - PROCESS | 24751 | Values: 1263.3 1453.4 1490.0 1653.2 1856.0 7006.9 7384.2 7391.4 7574.0 7580.2 7338.3 7523.7 7538.5 7552.2 7552.2 1850.5 2134.3 2196.6 2220.4 2239.2 2262.6 2263.0 2266.8 2271.6 2278.5 2139.8 2140.5 2163.6 2172.6 2177.2 1746.5 2065.1 2118.6 2145.4 2151.2 2130.4 2135.4 2161.7 2164.1 2165.1 7365.0 7431.6 7437.6 7452.6 7454.0 4388.3 4550.1 4574.0 4576.7 4589.4 2902.7 2965.5 2982.6 3005.4 3026.3 900.8 941.7 943.7 949.2 955.8 9920.4 9937.1 9975.7 9979.4 10008.9 3920.2 4005.4 4056.3 4066.1 4092.4 8468.7 8564.6 8568.5 8583.0 8584.1 4468.8 4560.2 4562.7 4577.3 4592.2 3584.7 4062.1 4101.6 4188.1 4208.2 3524.1 3563.6 3607.2 3659.6 3712.9 1161.7 1162.8 1163.8 1171.1 1180.1 837.7 844.0 911.3 912.0 912.6 5091.5 5157.2 5162.1 5188.6 5290.0 896.9 906.5 915.1 939.0 943.8 3612.2 3710.1 3751.3 3756.7 3763.9 8786.8 9100.8 9214.9 9235.6 9254.4 8728.8 8963.5 9088.3 9208.5 9218.1 7031.3 7045.3 7118.4 7156.0 7169.4 4879.0 4942.2 4981.6 5320.9 5327.5 8398.2 8576.4 8582.0 8700.8 8703.9 7780.2 8273.8 8281.5 8708.8 8723.3 5505.2 6193.6 6289.6 6363.3 6586.4 7253.8 7292.9 7339.6 7345.9 7367.0 6518.6 6671.4 6719.6 6762.0 6817.0 6453.7 6464.4 6490.4 6517.3 6551.4 6116.2 6184.8 6200.9 6205.1 6223.8 4256.6 4475.5 4505.2 4507.4 4522.1 4642.2 4687.3 4687.6 4713.4 4738.5 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | [#4] prototype.html Cycles:180 Average:4009.06 Median:4539.48 stddev:1144.08 (25.2%) stddev-sans-first:1112.96 03:27:40 INFO - PROCESS | 24751 | Values: 302.7 306.9 312.6 317.6 318.2 4631.5 4646.7 4650.0 4650.9 4726.7 4536.0 4541.7 4570.6 4598.0 4600.4 3457.3 3558.9 3583.6 3674.1 3688.4 3642.4 3667.3 3677.5 3677.9 3702.4 3605.3 3620.1 3628.2 3634.2 3641.5 3436.4 3493.7 3622.2 3641.6 3655.3 3245.0 3245.8 3248.7 3274.8 3277.9 4329.7 4340.2 4368.1 4378.5 4396.9 3981.7 4094.9 4117.4 4120.8 4141.6 4754.8 4766.1 4766.5 4775.1 4776.6 3551.9 3563.3 3571.6 3575.0 3578.9 4963.0 4973.6 4980.1 4989.6 4994.1 3442.8 3616.9 3632.2 3669.9 3674.8 3704.1 3705.8 3708.2 3713.4 3713.7 4125.9 4126.2 4126.3 4135.0 4148.7 4595.6 4758.3 4817.3 4819.4 4823.7 1222.3 1228.8 1240.1 1240.7 1242.9 835.7 837.7 838.8 867.5 884.8 3907.0 3911.6 4123.0 4226.9 4230.8 4976.6 5002.2 5027.7 5033.0 5035.5 4172.1 4247.9 4290.0 4304.4 4307.8 2512.2 2552.5 2556.0 2562.7 2562.8 4489.6 4523.8 4545.6 4575.1 4575.5 4893.9 4921.6 4922.2 4952.1 4956.0 4376.8 4709.8 4714.0 4721.5 4735.6 4935.2 4946.8 4970.8 5020.5 5043.6 4879.4 4892.0 4901.8 4904.8 4921.7 4391.9 4629.2 4678.7 4694.7 4702.6 3598.2 3642.8 3653.2 3688.4 3701.5 4927.3 4938.3 4963.5 4974.1 4992.8 4555.3 4838.4 4839.5 4853.2 4853.2 4769.7 4778.8 4798.7 4808.8 4819.9 4747.5 4772.4 4792.2 4795.4 4801.4 4537.3 4571.2 4827.8 4844.5 4846.6 4701.2 4741.2 4765.6 4770.4 4793.2 03:27:40 INFO - PROCESS | 24751 | 03:27:40 INFO - PROCESS | 24751 | [#5] yui.html Cycles:180 Average:11883.73 Median:543.28 stddev:13544.11 (2493.0%) stddev-sans-first:13556.24 03:27:40 INFO - PROCESS | 24751 | Values: 738.6 763.6 787.3 788.1 797.7 10348.7 11121.8 11244.2 11324.1 11335.9 12221.8 12265.4 12282.6 12285.1 12409.5 650.7 832.5 842.4 857.0 865.5 858.6 862.6 863.9 864.1 865.1 923.3 923.8 923.8 924.8 925.4 689.4 879.3 899.7 904.8 910.6 674.1 676.7 676.9 677.6 678.2 11046.7 11070.6 11085.9 11107.9 11138.5 11440.7 11718.6 11967.3 12587.9 12595.5 8810.7 10092.3 10578.7 10921.3 10929.7 4140.5 4184.9 4302.1 4322.7 4335.3 40289.2 40575.2 40848.4 40916.8 40947.0 9985.6 10076.5 10133.5 10373.2 10874.9 17026.5 17034.7 17053.1 17072.8 17106.9 6012.6 6076.1 6131.7 6509.6 6551.7 3415.7 3429.4 3472.3 3486.6 3494.9 2832.3 2920.9 2934.0 2947.7 2949.8 537.1 537.2 537.2 543.0 546.0 474.1 475.2 522.5 543.6 558.4 7501.8 7546.7 7674.8 7710.5 7806.1 580.6 583.3 597.6 615.8 620.5 3263.5 3540.9 3579.5 3612.4 3641.7 48502.5 48606.8 48805.5 49390.8 49556.0 45026.5 45063.0 45123.5 45239.3 45905.8 40578.4 40594.4 40927.6 41255.0 41567.6 6953.8 7014.5 7058.5 7118.8 7134.6 26792.3 27349.7 28016.4 28391.7 28605.1 33773.5 35496.8 36153.5 36312.6 37162.8 9075.3 9159.4 9205.9 9302.0 9371.8 9351.5 9610.0 9666.9 9865.3 10003.9 8995.5 8997.6 9036.1 9138.6 9702.6 8672.6 8744.8 9030.5 9297.0 9313.2 9211.9 9254.6 9302.0 9350.5 9350.8 7794.8 7957.4 8068.6 8238.2 8253.3 7649.8 7847.9 7950.3 8106.9 8344.6 03:27:40 INFO - PROCESS | 24751 | -------- Summary: end -------- 03:27:40 INFO - PROCESS | 24751 | 03:27:41 INFO - TEST-INFO | 24751: exit 0 03:27:41 INFO - TEST-OK | dromaeo_css | took 1116004ms 03:27:41 INFO - TEST-START | kraken 03:27:41 INFO - operating with platform_type : linux_ 03:27:41 INFO - Initialising browser for kraken test... 03:27:41 INFO - TEST-INFO | started process 24929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqagq5u/profile http://localhost:43564/getInfo.html) 03:27:45 INFO - PROCESS | 24929 | __metrics Screen width/height:1600/1200 03:27:45 INFO - PROCESS | 24929 | colorDepth:24 03:27:45 INFO - PROCESS | 24929 | Browser inner width/height: 1024/697 03:27:45 INFO - PROCESS | 24929 | __metrics 03:27:46 ERROR - PROCESS | 24929 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:27:46 INFO - TEST-INFO | 24929: exit 0 03:27:46 INFO - Browser initialized. 03:27:46 INFO - Running cycle 1/1 for kraken test... 03:27:46 INFO - TEST-INFO | started process 25008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqagq5u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:58 INFO - PROCESS | 25008 | RSS: Main: 153063424 03:27:58 INFO - PROCESS | 25008 | 03:28:01 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43564/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:02 INFO - PROCESS | 25008 | RSS: Main: 208945152 03:28:02 INFO - PROCESS | 25008 | 03:28:05 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43564/tests/kraken/driver.html?testName=audio-dft) 03:28:05 INFO - PROCESS | 25008 | RSS: Main: 197001216 03:28:05 INFO - PROCESS | 25008 | 03:28:08 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43564/tests/kraken/driver.html?testName=audio-fft) 03:28:09 INFO - PROCESS | 25008 | RSS: Main: 265953280 03:28:09 INFO - PROCESS | 25008 | 03:28:11 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43564/tests/kraken/driver.html?testName=audio-oscillator) 03:28:12 INFO - PROCESS | 25008 | RSS: Main: 175005696 03:28:12 INFO - PROCESS | 25008 | 03:28:14 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:15 INFO - PROCESS | 25008 | RSS: Main: 178958336 03:28:15 INFO - PROCESS | 25008 | 03:28:18 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43564/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:19 INFO - PROCESS | 25008 | RSS: Main: 214781952 03:28:19 INFO - PROCESS | 25008 | 03:28:22 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43564/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:23 INFO - PROCESS | 25008 | RSS: Main: 213950464 03:28:23 INFO - PROCESS | 25008 | 03:28:26 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43564/tests/kraken/driver.html?testName=json-parse-financial) 03:28:27 INFO - PROCESS | 25008 | RSS: Main: 213848064 03:28:27 INFO - PROCESS | 25008 | 03:28:28 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:29 INFO - PROCESS | 25008 | RSS: Main: 209645568 03:28:29 INFO - PROCESS | 25008 | 03:28:31 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:32 INFO - PROCESS | 25008 | RSS: Main: 212279296 03:28:32 INFO - PROCESS | 25008 | 03:28:34 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:35 INFO - PROCESS | 25008 | RSS: Main: 214466560 03:28:35 INFO - PROCESS | 25008 | 03:28:38 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:38 INFO - PROCESS | 25008 | RSS: Main: 218411008 03:28:38 INFO - PROCESS | 25008 | 03:28:41 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:42 INFO - PROCESS | 25008 | RSS: Main: 217661440 03:28:42 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | Cycle 1(1): loaded http://localhost:43564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43564/tests/kraken/driver.html?testName=ai-astar) 03:28:44 INFO - PROCESS | 25008 | RSS: Main: 263790592 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | __start_tp_report 03:28:44 INFO - PROCESS | 25008 | _x_x_mozilla_page_load 03:28:44 INFO - PROCESS | 25008 | _x_x_mozilla_page_load_details 03:28:44 INFO - PROCESS | 25008 | |i|pagename|runs| 03:28:44 INFO - PROCESS | 25008 | |0;ai-astar;117;112;117;121;119;115;116;117;114;118 03:28:44 INFO - PROCESS | 25008 | |1;audio-beat-detection;159;146;162;218;141;159;157;147;184;139 03:28:44 INFO - PROCESS | 25008 | |2;audio-dft;163;165;162;166;165;163;171;163;164;162 03:28:44 INFO - PROCESS | 25008 | |3;audio-fft;77;77;77;146;79;81;79;78;127;76 03:28:44 INFO - PROCESS | 25008 | |4;audio-oscillator;94;94;147;95;95;95;121;94;95;119 03:28:44 INFO - PROCESS | 25008 | |5;imaging-gaussian-blur;120;119;119;118;118;118;119;119;119;119 03:28:44 INFO - PROCESS | 25008 | |6;imaging-darkroom;148;148;147;149;148;148;147;148;149;149 03:28:44 INFO - PROCESS | 25008 | |7;imaging-desaturate;107;95;96;97;96;95;95;96;95;96 03:28:44 INFO - PROCESS | 25008 | |8;json-parse-financial;67;66;66;65;66;67;68;68;66;67 03:28:44 INFO - PROCESS | 25008 | |9;json-stringify-tinderbox;65;64;64;64;65;64;64;64;64;65 03:28:44 INFO - PROCESS | 25008 | |10;stanford-crypto-aes;92;86;86;85;90;85;88;90;166;91 03:28:44 INFO - PROCESS | 25008 | |11;stanford-crypto-ccm;145;159;143;140;151;142;140;161;156;152 03:28:44 INFO - PROCESS | 25008 | |12;stanford-crypto-pbkdf2;178;187;180;182;180;180;180;180;177;182 03:28:44 INFO - PROCESS | 25008 | |13;stanford-crypto-sha256-iterative;75;71;71;71;72;70;69;69;68;72 03:28:44 INFO - PROCESS | 25008 | __end_tp_report 03:28:44 INFO - PROCESS | 25008 | __start_cc_report 03:28:44 INFO - PROCESS | 25008 | _x_x_mozilla_cycle_collect,1942 03:28:44 INFO - PROCESS | 25008 | __end_cc_report 03:28:44 INFO - PROCESS | 25008 | __startTimestamp1462876124366__endTimestamp 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | ------- Summary: start ------- 03:28:44 INFO - PROCESS | 25008 | Number of tests: 14 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#0] ai-astar Cycles:10 Average:116.60 Median:117.00 stddev:2.55 (2.2%) stddev-sans-first:2.70 03:28:44 INFO - PROCESS | 25008 | Values: 117.0 112.0 117.0 121.0 119.0 115.0 116.0 117.0 114.0 118.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#1] audio-beat-detection Cycles:10 Average:161.20 Median:159.00 stddev:23.82 (15.0%) stddev-sans-first:25.25 03:28:44 INFO - PROCESS | 25008 | Values: 159.0 146.0 162.0 218.0 141.0 159.0 157.0 147.0 184.0 139.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.79 03:28:44 INFO - PROCESS | 25008 | Values: 163.0 165.0 162.0 166.0 165.0 163.0 171.0 163.0 164.0 162.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#3] audio-fft Cycles:10 Average:89.70 Median:77.50 stddev:25.11 (32.4%) stddev-sans-first:26.21 03:28:44 INFO - PROCESS | 25008 | Values: 77.0 77.0 77.0 146.0 79.0 81.0 79.0 78.0 127.0 76.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.50 stddev:18.19 (19.3%) stddev-sans-first:18.86 03:28:44 INFO - PROCESS | 25008 | Values: 94.0 94.0 147.0 95.0 95.0 95.0 121.0 94.0 95.0 119.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:119.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 03:28:44 INFO - PROCESS | 25008 | Values: 120.0 119.0 119.0 118.0 118.0 118.0 119.0 119.0 119.0 119.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:28:44 INFO - PROCESS | 25008 | Values: 148.0 148.0 147.0 149.0 148.0 148.0 147.0 148.0 149.0 149.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:3.65 (3.8%) stddev-sans-first:0.71 03:28:44 INFO - PROCESS | 25008 | Values: 107.0 95.0 96.0 97.0 96.0 95.0 95.0 96.0 95.0 96.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 03:28:44 INFO - PROCESS | 25008 | Values: 67.0 66.0 66.0 65.0 66.0 67.0 68.0 68.0 66.0 67.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:28:44 INFO - PROCESS | 25008 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 65.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#10] stanford-crypto-aes Cycles:10 Average:95.90 Median:89.00 stddev:24.76 (27.8%) stddev-sans-first:26.22 03:28:44 INFO - PROCESS | 25008 | Values: 92.0 86.0 86.0 85.0 90.0 85.0 88.0 90.0 166.0 91.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:151.50 stddev:7.95 (5.2%) stddev-sans-first:8.31 03:28:44 INFO - PROCESS | 25008 | Values: 145.0 159.0 143.0 140.0 151.0 142.0 140.0 161.0 156.0 152.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:180.00 stddev:2.72 (1.5%) stddev-sans-first:2.71 03:28:44 INFO - PROCESS | 25008 | Values: 178.0 187.0 180.0 182.0 180.0 180.0 180.0 180.0 177.0 182.0 03:28:44 INFO - PROCESS | 25008 | 03:28:44 INFO - PROCESS | 25008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.99 (2.8%) stddev-sans-first:1.41 03:28:44 INFO - PROCESS | 25008 | Values: 75.0 71.0 71.0 71.0 72.0 70.0 69.0 69.0 68.0 72.0 03:28:44 INFO - PROCESS | 25008 | -------- Summary: end -------- 03:28:44 INFO - PROCESS | 25008 | 03:28:45 INFO - TEST-INFO | 25008: exit 0 03:28:45 INFO - TEST-OK | kraken | took 63819ms 03:28:45 INFO - SUITE-END | took 1179s 03:28:45 INFO - Completed test suite (00:19:40) 03:28:45 INFO - javascript benchmark 03:28:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.6970098438687, 2636.222314417247, 2663.3874208931943, 2670.893164273429, 2676.2238950704295, 4558.6581006424485, 4579.542045795419, 4629.814807407708, 4650.813967441299, 4710.057988402316, 4587.495375508692, 4624.653151013671, 4672.229082201433, 4684.344191813149, 4725.432948046231, 4215.578442155791, 4217.240896638611, 4289.9356509652225, 4352.434183556134, 4491.281394976804, 4352.368906508555, 4384.0355121873135, 4410.140022695576, 4412.029353542232, 4429.136318417894, 4183.288840897025, 4195.454590903194, 4211.410402543646, 4214.7681877496725, 4288.76411797351, 4285.550017248175, 4299.290617048183, 4344.56554344563, 4354.368616550582, 4358.6730995175485, 4349.478062632473, 4360.89097772555, 4360.934585981213, 4371.388005679208, 4422.823087076513, 4470.128324976631, 4581.129585378767, 4614.469336026366, 4628.3288923105965, 4700.918788678623, 5069.721165335905, 5086.3133476980875, 5087.414947281036, 5125.513076257786, 5145.228215767627, 4872.269159626049, 5066.06277838601, 5091.847244582668, 5114.744262786883, 5151.562117220041, 4655.068986202739, 4666.0901124280435, 4687.531246875354, 4721.126591580569, 4733.692309999839, 5078.085944529947, 5167.767450464738, 5172.069027574998, 5195.116830138885, 5199.610029247746, 4840.104580652591, 4933.4819843915875, 5040.621953353513, 5058.861756104847, 5072.949270507322, 5010.348654674869, 5049.192129259301, 5098.031374038921, 5112.284280200774, 5122.743862806845, 5011.749412529359, 5036.992601479718, 5042.991401719597, 5053.267276244924, 5102.107131252016, 4786.617070634341, 4880.975595122072, 4905.23968784839, 5034.874128146826, 5053.267276244924, 4248.256555102845, 4257.957420425818, 4275.615194632498, 4275.978620106879, 4279.33670281107, 3655.2324011957785, 3705.7035437164964, 3710.4990826238113, 3730.850765969385, 3737.5328083989502, 4102.733322334038, 4140.4617399737845, 4219.936700949488, 4235.30117530604, 4263.552327005682, 5037.5214354636255, 5062.898742025139, 5076.010178015325, 5085.338905942203, 5123.897522049539, 4288.927768057985, 4290.549492303326, 4330.545292744279, 4330.631896288788, 4334.50153232376, 4081.6122468365456, 4407.581279778416, 4489.506154323022, 4559.452865656076, 4579.931301030487, 4707.599854012447, 4722.433308003062, 4725.149473094876, 4739.265413860857, 4800.279958006327, 5001.549860512571, 5018.971110922179, 5031.723255220998, 5045.041442125985, 5047.671901326402, 4531.003179300548, 4726.527347265246, 4737.739424331695, 4764.737939413366, 4780.330753694555, 4950.851474455772, 4984.252362145708, 5013.423456302426, 5017.197248440232, 5034.421041580265, 4879.829205977774, 4935.185694360391, 4954.727489988085, 4963.9327544576645, 5013.523715247045, 4836.709797412166, 4883.633727470383, 4917.213245880642, 4920.581750551243, 4937.456879743298, 4916.434610019751, 4929.482404347492, 4955.058538877602, 4968.826091086795, 5003.924941125959, 4661.720296782204, 4696.084263568571, 4726.810927562997, 4875.268709693574, 4882.36529251195, 4887.095887260868, 4897.436794768647, 4899.583535399531, 4905.950940490549, 4974.676646017997, 4787.832425865078, 4828.66199366041, 4829.179039563212, 4830.7826147824135, 4868.90262194747], "value": 4605.2615367212875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.5322489596708, 558.8100045984365, 569.8917205730913, 577.3360635269438, 598.9101634754788, 28540.286492837662, 31617.84191079044, 31837.52243716346, 39840.0, 40668.0, 37924.62075379246, 41789.37315940263, 42275.0, 42423.818213633946, 42751.78624106883, 7941.523508589488, 8000.359971202319, 8034.0, 8068.515889046646, 8072.878906816402, 7784.922150778476, 7908.44640875139, 7929.484583502054, 7935.603219838985, 7959.482633628824, 7936.920630793676, 7946.125926148119, 7974.760757177294, 8014.639341229658, 8018.67925282988, 7902.802429939269, 7918.1290058093855, 7928.6035698214855, 7930.881036784453, 7932.286094251545, 7856.450048496607, 7889.487183333065, 7904.644291006918, 7925.603719814044, 7950.880736788953, 39506.60493395087, 39925.0, 39927.80036099801, 40006.1994110559, 40104.59895401067, 3231.1275955491888, 3323.4350160472777, 3338.2488939988552, 3372.881949131793, 3732.9626703733156, 28614.713852861412, 28625.14124576266, 29033.37082864642, 29133.12600621985, 29208.123756287347, 3153.4323821712082, 3191.1419835544853, 3200.9199770005703, 3203.7116659500757, 3301.240714635623, 175382.0, 176506.0, 176507.0, 177673.0, 246760.29859551942, 47601.52398475971, 47815.0, 48013.75993120082, 48070.75964620154, 48307.516924831005, 34886.30227395438, 35811.28377432489, 35836.0, 36647.633523664954, 36825.07937301535, 14423.0, 14636.04865683727, 14657.04729192599, 14681.77977330341, 14748.483803066842, 11000.954909283766, 11088.611898583511, 11093.168012399103, 11115.610953616746, 11152.721181970515, 18678.719819202724, 18684.906575467037, 18710.81289187118, 18723.81276187248, 18810.717839232424, 7321.853562928818, 7336.156342020736, 7414.962925185448, 7433.8141546461775, 7462.925370746331, 868.8566386546149, 920.4845286639503, 924.9815003699888, 998.4209158687944, 1016.7305663999047, 27373.589396159074, 28490.433026183346, 28648.570271445944, 29028.564571531442, 29031.564526532118, 925.2274350916925, 1009.4750729620556, 1015.1929216272933, 1018.8217062014118, 1039.7868436970402, 15035.398584056735, 15225.923870380577, 15319.846801532065, 15333.531864204751, 15360.84639153594, 374006.0, 375686.0, 376873.0, 377862.0, 377922.0, 48523.5147648526, 49428.50571494311, 49590.75204623954, 49808.50191498111, 49920.750396247786, 1150.3040660400504, 1231.3289257354763, 1265.1523479268913, 1281.442572480955, 1283.0120806978762, 27732.168034958984, 28738.425231495672, 29219.042858927904, 29275.0, 29707.257318566346, 41804.0, 41929.161416772105, 42621.0, 42672.57327426686, 42713.35929960991, 292678.0, 294508.0, 294621.0, 296359.0, 296703.0, 22673.0, 25108.0, 25327.36681582975, 25845.612315814902, 27100.32249193786, 41533.37699934564, 41860.58139418567, 41882.58117418909, 42626.0, 42700.78649606856, 36374.0, 36407.08982275464, 36954.63045369512, 36997.0, 37207.81396093002, 34413.65586344105, 37214.0, 37368.62631373652, 37976.81011594924, 38245.80877095708, 36485.63514364822, 37000.07499812418, 37154.0, 37390.62609373871, 38391.808040960736, 31657.36858518999, 33888.15279618029, 34156.82921585376, 34360.14099647529, 34525.65474345224, 25437.491250175262, 25989.6101558473, 25997.350066248495, 26000.8699956499, 26024.34939126537], "value": 17323.025259390586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.68508110646496, 374.94375843623453, 384.50398985308954, 395.08537735143125, 401.6385253272057, 16579.83420165798, 17126.571835704115, 17669.64660706785, 17888.731669024975, 17913.37303194387, 16659.83340166598, 16895.91552042241, 17466.301347946068, 17583.032933188668, 17761.82238177618, 4984.999999999991, 5179.482051794828, 5202.479752024786, 5212.817551385702, 5220.973895130519, 3619.5294611700574, 5139.869228769665, 5896.23348964634, 5913.024350982083, 5999.370066143036, 5926.1110833374905, 5944.583879128462, 5945.435183657567, 5950.404959504058, 5978.8804223915495, 5707.914381284284, 5821.912671309934, 5878.5003274721275, 5910.0, 5937.732802023897, 4890.902181956341, 5091.847244582668, 5120.436751957282, 5138.100832354323, 5152.665076770036, 21267.5746485071, 21310.254141105142, 21518.139274429002, 21549.784502154933, 21590.568188636298, 1983.623111608804, 1990.6914428263642, 2045.6420126477806, 2296.0, 2306.815454763615, 12030.759384812342, 13250.66873328165, 13364.264965426995, 13501.527446539323, 13889.0, 1756.929722811086, 1794.883332583378, 1808.5659441734022, 1829.570051038005, 1890.3100368365585, 62265.6886715568, 64380.678096609685, 66032.33967660357, 66145.3385466144, 66431.0, 9598.42409455435, 9619.038096190325, 9691.660791872391, 9702.805943881083, 9764.121229089416, 12725.809112863315, 12741.936290318488, 12838.42227099764, 12844.779745924123, 12869.0, 7442.739504117439, 7485.0, 7502.512336698097, 7627.970224019798, 7662.808429789188, 7289.635518224173, 7326.780196594111, 7358.153812311546, 7451.627418629047, 7455.813604659818, 6145.385461453909, 6266.060090986389, 6277.748890044347, 6307.274663413767, 6366.790309841208, 1642.2199455258656, 1711.922963466647, 1739.8347157020062, 1748.825117488241, 1750.6323672028761, 893.3523195683077, 966.8501382285757, 969.9951500242454, 987.2200961240683, 1034.7288296860067, 16570.254338554794, 17253.341597768784, 17264.827351726322, 17695.646087078185, 17761.111944402728, 898.5058217980085, 931.7204838548544, 941.6327632223438, 946.4652471353663, 951.2485136742034, 9673.758156046015, 10249.9487502562, 10283.28017038815, 10396.740081498023, 10495.947520262349, 394622.0, 413475.0, 427977.0, 430794.0, 432023.0, 68280.31719682839, 69039.0, 69426.0, 69556.0, 69871.30128698648, 978.1392374710209, 1008.3496144986443, 1019.9694009179736, 1020.433659319085, 1025.9281850270409, 15284.235788210768, 15639.0, 15679.0, 15731.21343932776, 16028.358865645243, 32690.182745431553, 33126.503102453, 33168.83415582906, 33719.15702107369, 34008.48987265144, 44492.77753611211, 44652.77673611741, 44694.55305446904, 44699.32951005803, 44808.103837922405, 7668.961655191688, 7703.961480192564, 7737.3036426721865, 7771.378289736695, 7797.844043119219, 11676.416179191176, 11754.11844111678, 11788.410579470821, 11899.821502677294, 12091.69770755703, 10252.64115755945, 10258.53836577341, 10456.63401780934, 10489.47552622381, 10499.527521261409, 10033.1973442123, 10117.89882101199, 10179.440130792878, 10554.419506926886, 10581.100606448537, 10159.796804064024, 10193.439360835226, 10385.740356491147, 10469.214808889212, 10852.023317901427, 7465.7013719450615, 7622.0, 7720.420968427503, 8065.798355041171, 8077.071136819341, 10145.594176232868, 10298.330608510723, 10312.896871031193, 10617.681469555926, 10711.625093121704], "value": 8487.013272105243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.2546797389539, 1453.367785013519, 1490.0091439192934, 1653.222985196957, 1855.999999999999, 7006.929930700691, 7384.150822655396, 7391.445641576883, 7574.0, 7580.204078571754, 7338.3395494405495, 7523.699052037912, 7538.472306938516, 7552.169261381244, 7552.207018263086, 1850.5188650950784, 2134.253011445997, 2196.626573482508, 2220.356096731954, 2239.1603148819195, 2262.6492893601435, 2262.9660555091687, 2266.7506574276817, 2271.5684020036224, 2278.487340348425, 2139.8181154601875, 2140.4541841830387, 2163.6321825289738, 2172.630652789022, 2177.2162021672184, 1746.5022468596453, 2065.10168076887, 2118.5868755592664, 2145.442185031887, 2151.171798857451, 2130.4141361125658, 2135.4234356723755, 2161.654135338338, 2164.0694501364405, 2165.1123039553863, 7364.963175184143, 7431.628418579049, 7437.590932498711, 7452.552846829153, 7454.0, 4388.2539968205165, 4550.067236216568, 4573.977130114361, 4576.702514336557, 4589.380433641482, 2902.6661933877663, 2965.4810408178696, 2982.567527708492, 3005.443992861328, 3026.2585666511627, 900.8333458310168, 941.7410212191634, 943.7263193673826, 949.1647350331733, 955.7849483866144, 9920.355176913477, 9937.10566049059, 9975.650852220137, 9979.351342162809, 10008.94995525025, 3920.2159568086495, 4005.379166229239, 4056.269871423172, 4066.064805094845, 4092.3656833190903, 8468.745937621881, 8564.571771411529, 8568.485890846445, 8583.0, 8584.098669639598, 4468.798904049326, 4560.224761790503, 4562.68061235717, 4577.267637178035, 4592.219322715079, 3584.713222942158, 4062.1266427718183, 4101.569335219759, 4188.057687020457, 4208.179405015992, 3524.101354154674, 3563.572371315459, 3607.1703508193264, 3659.597444281127, 3712.888613341604, 1161.7095726068483, 1162.84301619282, 1163.831244469547, 1171.0807016492013, 1180.0972256223995, 837.6984285657159, 844.0335815491351, 911.2800887299092, 912.0, 912.6258234123977, 5091.465396133427, 5157.174852023733, 5162.109481557137, 5188.610854185951, 5290.047791397586, 896.8654701794652, 906.5286051253312, 915.0986278515657, 938.9530523473799, 943.8018016216671, 3612.2414292998237, 3710.109573702346, 3751.324761542894, 3756.6806821419937, 3763.8870833875026, 8786.780330491789, 9100.772480687903, 9214.861777073349, 9235.584398702074, 9254.35219534626, 8728.781780455412, 8963.507007114671, 9088.272938165062, 9208.539573021322, 9218.078192180863, 7031.29687031303, 7045.295470453017, 7118.359347658632, 7155.964220178866, 7169.426445884316, 4878.9512104878495, 4942.159832828356, 4981.6014718823135, 5320.920186197132, 5327.547158491417, 8398.202170793766, 8576.399652024547, 8581.95709021451, 8700.78248043804, 8703.86944195825, 7780.183080776437, 8273.83452330938, 8281.461704989157, 8708.78228044304, 8723.345749068973, 5505.229267902577, 6193.566450348432, 6289.622622642656, 6363.331850155852, 6586.407223349922, 7253.782386528413, 7292.854142917005, 7339.59632220233, 7345.926540734525, 7367.042284502981, 6518.608883466817, 6671.39957403836, 6719.563228390139, 6762.0, 6816.965915170393, 6453.741850326122, 6464.353564643498, 6490.350964903472, 6517.315681853337, 6551.377619126175, 6116.17431646722, 6184.752609895554, 6200.875982480235, 6205.100260462298, 6223.782167624111, 4256.553061928576, 4475.5300693426725, 4505.166544189336, 4507.368968344369, 4522.140793249272, 4642.16441040616, 4687.296905464208, 4687.648426368104, 4713.410823647044, 4738.50245724194], "value": 4064.420116137603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.7381315162385, 306.94321550513155, 312.58738465225906, 317.6156850211247, 318.2457575545956, 4631.536846315366, 4646.744429056401, 4649.976750116253, 4650.860474185772, 4726.66913316068, 4535.954640453603, 4541.65937554683, 4570.611498022664, 4597.954020459794, 4600.42494688164, 3457.308538292339, 3558.946615800765, 3583.5878873929573, 3674.0814796300924, 3688.4467329900463, 3642.3990041643096, 3667.2848794484953, 3677.5035370224946, 3677.926441471169, 3702.426123950792, 3605.3149901518627, 3620.1311685195496, 3628.219932714466, 3634.218642991756, 3641.5083963664965, 3436.415809312423, 3493.6681015303634, 3622.2212224371888, 3641.635836416337, 3655.323765103464, 3245.0, 3245.799054349882, 3248.6842828654435, 3274.836258187105, 3277.918052048694, 4329.653627709808, 4340.197063543223, 4368.148211098837, 4378.452693413324, 4396.934045989313, 3981.7212795104356, 4094.856680016215, 4117.402976568411, 4120.773357465338, 4141.565135660742, 4754.833580824655, 4766.094442055998, 4766.547178018082, 4775.068861571995, 4776.6116941529235, 3551.911202219965, 3563.3407819553468, 3571.6428357164336, 3575.0, 3578.910527236814, 4962.975185124087, 4973.62697797663, 4980.078685443204, 4989.5758860496535, 4994.051130285234, 3442.7590068695454, 3616.8734094306574, 3632.20091579852, 3669.94495082574, 3674.81625918703, 3704.073981504624, 3705.7591256568235, 3708.1841994761107, 3713.350163721338, 3713.665770080706, 4125.876223713293, 4126.174765047002, 4126.339785634284, 4135.0, 4148.709590328708, 4595.586397224199, 4758.262469317261, 4817.253325734517, 4819.397575303087, 4823.686460380064, 1222.2544248008708, 1228.7726770547476, 1240.1009268280425, 1240.6712221261193, 1242.8508578970582, 835.6699103853944, 837.7151768398774, 838.8196537744415, 867.5358683104508, 884.8186121845135, 3907.0, 3911.5501717302304, 4122.958770412258, 4226.936595951063, 4230.767307798101, 4976.62675299354, 5002.224655178453, 5027.748612569357, 5032.974835125801, 5035.546800787946, 4172.144710334374, 4247.851325203603, 4289.978550107292, 4304.440422745023, 4307.763073031013, 2512.2212114244644, 2552.5405427023315, 2555.9744402556107, 2562.7181010088875, 2562.769350758441, 4489.5959363656775, 4523.819047238139, 4545.568171023748, 4575.130725162208, 4575.519570445122, 4893.853184404403, 4921.572743904299, 4922.212446008622, 4952.108620448282, 4955.975220123876, 4376.824927002885, 4709.788059537329, 4713.976430117896, 4721.527847215389, 4735.644826637947, 4935.185694360391, 4946.802127914843, 4970.826021089245, 5020.4979502050965, 5043.646944713835, 4879.4388645304825, 4891.951080489292, 4901.828436004723, 4904.803807847647, 4921.680090794087, 4391.8682439526865, 4629.166749985035, 4678.7308155545215, 4694.671373003994, 4702.553257440538, 3598.172420343283, 3642.8360723766964, 3653.1597732521136, 3688.428293614494, 3701.5188025556504, 4927.334809800775, 4938.333325001223, 4963.503649635008, 4974.129527332775, 4992.800287988585, 4555.339475775928, 4838.371011768448, 4839.516048395132, 4853.174960256694, 4853.223484242504, 4769.689970151929, 4778.761061946958, 4798.73606951621, 4808.831690890942, 4819.879503012453, 4747.531283732509, 4772.379590653193, 4792.185328494234, 4795.376601041842, 4801.399825021872, 4537.296719008559, 4571.1543364477675, 4827.782749776339, 4844.539768721966, 4846.5638092571835, 4701.22429799093, 4741.193997020446, 4765.571098601143, 4770.356001939694, 4793.209120495079], "value": 3653.908826932261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.641758747008, 763.6067425275982, 787.322902304018, 788.1291173253559, 797.6689673785379, 10348.741281467966, 11121.777564448716, 11244.212905096647, 11324.094072474214, 11335.886641133586, 12221.816672749894, 12265.448054837532, 12282.57011004615, 12285.14004019719, 12409.503619855195, 650.6519012328405, 832.546262287055, 842.389267780857, 857.0401150711212, 865.4850364033422, 858.6393714639835, 862.5557837713583, 863.8531449653574, 864.1056506515757, 865.0657290126649, 923.2890674180877, 923.7505873414174, 923.8383282925495, 924.7549399409128, 925.3753716241511, 689.3726708695089, 879.3229213505597, 899.6851102114273, 904.7602385367883, 910.5947853205327, 674.0664180110533, 676.6954870308381, 676.864627074587, 677.6273049822578, 678.2471456683078, 11046.668599942015, 11070.612528561462, 11085.944570277177, 11107.888921110767, 11138.49876755548, 11440.71398215043, 11718.648440546796, 11967.341796201206, 12587.874121258761, 12595.496180152782, 8810.735677929672, 10092.293539452241, 10578.735531611694, 10921.344719316867, 10929.672109836718, 4140.5282196124945, 4184.916301673949, 4302.139572085595, 4322.654187664979, 4335.306350983859, 40289.19421611552, 40575.18849622991, 40848.387274190914, 40916.79541602303, 40947.0, 9985.550650220757, 10076.546555405024, 10133.493325333704, 10373.170146388271, 10874.891251087545, 17026.489205323862, 17034.659306813795, 17053.062081585384, 17072.829271707124, 17106.91446542759, 6012.609180403259, 6076.118962750376, 6131.662758548234, 6509.609423434609, 6551.705173267214, 3415.743819213519, 3429.3655673700446, 3472.3055388922317, 3486.5816102067915, 3494.8951531454095, 2832.2919270182456, 2920.8685609147637, 2933.9706602934125, 2947.6904924982996, 2949.7640188785276, 537.1110811606796, 537.1566640374652, 537.2290762755458, 542.9945700543024, 546.0471477272185, 474.0779184486141, 475.177942160065, 522.4723029739914, 543.565147881701, 558.3606770248043, 7501.849963000709, 7546.735864244725, 7674.808129796688, 7710.498817576839, 7806.1413244543055, 580.5964854426218, 583.3262581718122, 597.5757212379173, 615.796787060269, 620.5066971757374, 3263.543103965447, 3540.946885796715, 3579.5167652367118, 3612.385894397906, 3641.7450778445786, 48502.5149748498, 48606.75696621565, 48805.511944880804, 49390.75304623526, 49556.0, 45026.54973450289, 45063.0, 45123.548764511936, 45239.321410178876, 45905.7704711481, 40578.391324129574, 40594.391084133764, 40927.59072409238, 41255.0, 41567.58432415637, 6953.826154346182, 7014.473914456538, 7058.505904586835, 7118.750843720445, 7134.571925684476, 26792.33019174536, 27349.726502734717, 28016.439671206055, 28391.716082838906, 28605.141845743827, 33773.493397599545, 35496.82251588725, 36153.45769813402, 36312.63687363092, 37162.814185928895, 9075.27397808187, 9159.371269399018, 9205.907940920504, 9301.953490232505, 9371.765705857408, 9351.485668288038, 9609.951950240204, 9666.854997175189, 9865.26010549226, 10003.899961000297, 8995.505247211466, 8997.595108220277, 9036.096390360912, 9138.588763505792, 9702.563384647849, 8672.609732562176, 8744.781380465285, 9030.548472576213, 9297.0, 9313.208377288007, 9211.907880921373, 9254.629814807333, 9302.0, 9350.53247337644, 9350.81298374015, 7794.844103118019, 7957.363410926996, 8068.556229407439, 8238.176182381954, 8253.257206851413, 7649.847003060019, 7847.882281765664, 7950.324222440926, 8106.9189308108525, 8344.624491897757], "value": 5668.806969729409, "unit": "score"}], "name": "dromaeo_css", "value": 6203.768996665649, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 117.0, 121.0, 119.0, 115.0, 116.0, 117.0, 114.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 146.0, 162.0, 218.0, 141.0, 159.0, 157.0, 147.0, 184.0, 139.0], "value": 161.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 166.0, 165.0, 163.0, 171.0, 163.0, 164.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 146.0, 79.0, 81.0, 79.0, 78.0, 127.0, 76.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 147.0, 95.0, 95.0, 95.0, 121.0, 94.0, 95.0, 119.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 119.0, 118.0, 118.0, 118.0, 119.0, 119.0, 119.0, 119.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 67.0, 68.0, 68.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 86.0, 85.0, 90.0, 85.0, 88.0, 90.0, 166.0, 91.0], "value": 95.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 159.0, 143.0, 140.0, 151.0, 142.0, 140.0, 161.0, 156.0, 152.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 187.0, 180.0, 182.0, 180.0, 180.0, 180.0, 180.0, 177.0, 182.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 71.0, 71.0, 71.0, 72.0, 70.0, 69.0, 69.0, 68.0, 72.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1627.6, "alertThreshold": 2.0}]} 03:28:45 INFO - Return code: 0 03:28:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:28:45 ERROR - # TBPL SUCCESS # 03:28:45 INFO - Running post-action listener: _resource_record_post_action 03:28:45 INFO - ##### 03:28:45 INFO - ##### Finished run-tests step (success) 03:28:45 INFO - ##### 03:28:45 INFO - Running post-run listener: _resource_record_post_run 03:28:46 INFO - Total resource usage - Wall time: 1197s; CPU: 26.0%; Read bytes: 4096; Write bytes: 285413376; Read time: 16; Write time: 194428 03:28:46 INFO - install - Wall time: 16s; CPU: 25.0%; Read bytes: 0; Write bytes: 6062080; Read time: 0; Write time: 468 03:28:46 INFO - run-tests - Wall time: 1181s; CPU: 26.0%; Read bytes: 4096; Write bytes: 273469440; Read time: 16; Write time: 190656 03:28:46 INFO - Running post-run listener: _upload_blobber_files 03:28:46 INFO - Blob upload gear active. 03:28:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:46 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 03:28:46 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'] 03:28:46 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 03:28:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:47 INFO - (blobuploader) - INFO - Done attempting. 03:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:48 INFO - (blobuploader) - INFO - Done attempting. 03:28:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:48 INFO - Return code: 0 03:28:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8361c5cb4cec5ede76a3c71368f326c7c0ce54f99794412e8d017ef868c6781ec7e5ca0290d27ef0081fd40e94dc1ca9a760cc31ba6e56959fabfd8278611837", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69c0f48d06eb1c93ebf1d2ee85bb402f776efe280540d6633ce533a16586b477f977d88202ce2a748aee57ff704378d0985f43b313ac9147c7c9634ad056d308"} 03:28:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:48 INFO - Contents: 03:28:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8361c5cb4cec5ede76a3c71368f326c7c0ce54f99794412e8d017ef868c6781ec7e5ca0290d27ef0081fd40e94dc1ca9a760cc31ba6e56959fabfd8278611837", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69c0f48d06eb1c93ebf1d2ee85bb402f776efe280540d6633ce533a16586b477f977d88202ce2a748aee57ff704378d0985f43b313ac9147c7c9634ad056d308"} 03:28:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:48 INFO - Copying logs to upload dir... 03:28:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.236148 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-10 03:28:48.018829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:48.022169) ========= 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=1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256 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/8361c5cb4cec5ede76a3c71368f326c7c0ce54f99794412e8d017ef868c6781ec7e5ca0290d27ef0081fd40e94dc1ca9a760cc31ba6e56959fabfd8278611837", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69c0f48d06eb1c93ebf1d2ee85bb402f776efe280540d6633ce533a16586b477f977d88202ce2a748aee57ff704378d0985f43b313ac9147c7c9634ad056d308"} build_url:https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005409 build_url: 'https://queue.taskcluster.net/v1/task/FwjxHMbZQ6SPOgBLytVYTQ/artifacts/public/build/firefox-49.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/8361c5cb4cec5ede76a3c71368f326c7c0ce54f99794412e8d017ef868c6781ec7e5ca0290d27ef0081fd40e94dc1ca9a760cc31ba6e56959fabfd8278611837", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69c0f48d06eb1c93ebf1d2ee85bb402f776efe280540d6633ce533a16586b477f977d88202ce2a748aee57ff704378d0985f43b313ac9147c7c9634ad056d308"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:48.038062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:48.038811) ========= 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=1f5564757af27664ca02d71f000001b0-1462874805.923376-1879886256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002190 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:48.119023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:28:48.119348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:28:48.119665) ========= ========= Total master_lag: 0.16 =========