builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1460699593.0 results: success (0) buildid: 20160414215914 builduid: df1f749045324d89b1c656357ec84319 revision: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:12.996556) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:12.997103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:12.997570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:13.015372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:13.015669) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 22:53:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-04-14 22:53:13 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089890 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:13.222649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:13.223055) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:13.266463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 22:53:13.266839) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 --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 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 --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=82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 22:53:14,041 truncating revision to first 12 chars 2016-04-14 22:53:14,041 Setting DEBUG logging. 2016-04-14 22:53:14,041 attempt 1/10 2016-04-14 22:53:14,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a88d4e4b4e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 22:53:14,811 unpacking tar archive at: fx-team-5a88d4e4b4e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 22:53:14.404425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:14.404744) ========= script_repo_revision: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:14.405186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:14.405498) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 22:53:14.416221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-14 22:53:14.416532) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:15 INFO - MultiFileLogger online at 20160414 22:53:15 in /builds/slave/test 22:53:15 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 22:53:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:53:15 INFO - {'append_to_log': False, 22:53:15 INFO - 'base_work_dir': '/builds/slave/test', 22:53:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:53:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:53:15 INFO - 'branch': 'Fx-Team-Non-PGO', 22:53:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:15 INFO - 'config_files': ('talos/linux_config.py',), 22:53:15 INFO - 'default_actions': ('clobber', 22:53:15 INFO - 'read-buildbot-config', 22:53:15 INFO - 'download-and-extract', 22:53:15 INFO - 'populate-webroot', 22:53:15 INFO - 'create-virtualenv', 22:53:15 INFO - 'install', 22:53:15 INFO - 'run-tests'), 22:53:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:15 INFO - 'download_minidump_stackwalk': True, 22:53:15 INFO - 'download_symbols': 'ondemand', 22:53:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:15 INFO - 'installer_path': 'installer.exe', 22:53:15 INFO - 'log_level': 'info', 22:53:15 INFO - 'log_name': 'talos', 22:53:15 INFO - 'log_to_console': True, 22:53:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:15 INFO - 'opt_config_files': (), 22:53:15 INFO - 'pip_index': False, 22:53:15 INFO - 'sps_profile': False, 22:53:15 INFO - 'sps_profile_interval': 0, 22:53:15 INFO - 'suite': 'dromaeojs', 22:53:15 INFO - 'system_bits': '32', 22:53:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:15 INFO - 'title': 'talos-linux64-ix-066', 22:53:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:15 INFO - 'use_talos_json': True, 22:53:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:53:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:15 INFO - 'work_dir': 'build'} 22:53:15 INFO - ##### 22:53:15 INFO - ##### Running clobber step. 22:53:15 INFO - ##### 22:53:15 INFO - Running pre-action listener: _resource_record_pre_action 22:53:15 INFO - Running main action method: clobber 22:53:15 INFO - rmtree: /builds/slave/test/build 22:53:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:53:15 INFO - Running post-action listener: _resource_record_post_action 22:53:15 INFO - ##### 22:53:15 INFO - ##### Running read-buildbot-config step. 22:53:15 INFO - ##### 22:53:15 INFO - Running pre-action listener: _resource_record_pre_action 22:53:15 INFO - Running main action method: read_buildbot_config 22:53:15 INFO - Using buildbot properties: 22:53:15 INFO - { 22:53:15 INFO - "project": "", 22:53:15 INFO - "product": "firefox", 22:53:15 INFO - "script_repo_revision": "production", 22:53:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:53:15 INFO - "repository": "", 22:53:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:53:15 INFO - "buildid": "20160414215914", 22:53:15 INFO - "pgo_build": "False", 22:53:15 INFO - "basedir": "/builds/slave/test", 22:53:15 INFO - "buildnumber": 2839, 22:53:15 INFO - "slavename": "talos-linux64-ix-066", 22:53:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:53:15 INFO - "platform": "ubuntu64_hw", 22:53:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:53:15 INFO - "branch": "fx-team", 22:53:15 INFO - "repo_path": "integration/fx-team", 22:53:15 INFO - "revision": "5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816", 22:53:15 INFO - "stage_platform": "linux64", 22:53:15 INFO - "builduid": "df1f749045324d89b1c656357ec84319", 22:53:15 INFO - "slavebuilddir": "test" 22:53:15 INFO - } 22:53:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:53:15 INFO - Running post-action listener: _resource_record_post_action 22:53:15 INFO - ##### 22:53:15 INFO - ##### Running download-and-extract step. 22:53:15 INFO - ##### 22:53:15 INFO - Running pre-action listener: _resource_record_pre_action 22:53:15 INFO - Running main action method: download_and_extract 22:53:15 INFO - mkdir: /builds/slave/test/build/tests 22:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:15 INFO - https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:53:24 INFO - Downloaded 1361 bytes. 22:53:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:53:24 INFO - Using the following test package requirements: 22:53:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:53:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'jsshell-linux-x86_64.zip'], 22:53:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:24 INFO - https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:27 INFO - Downloaded 22202881 bytes. 22:53:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:53:28 INFO - Return code: 0 22:53:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:53:28 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')]} 22:53:28 INFO - https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:39 INFO - Downloaded 22202881 bytes. 22:53:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:53:41 INFO - Return code: 0 22:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:41 INFO - https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:53:42 INFO - Downloaded 10841076 bytes. 22:53:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:53:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:53:42 INFO - Return code: 0 22:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:42 INFO - https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:53:44 INFO - Downloaded 54449671 bytes. 22:53:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:53:44 INFO - mkdir: /builds/slave/test/properties 22:53:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:53:44 INFO - Writing to file /builds/slave/test/properties/build_url 22:53:44 INFO - Contents: 22:53:44 INFO - build_url:https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:53:45 INFO - Running post-action listener: _resource_record_post_action 22:53:45 INFO - Running post-action listener: set_extra_try_arguments 22:53:45 INFO - ##### 22:53:45 INFO - ##### Running populate-webroot step. 22:53:45 INFO - ##### 22:53:45 INFO - Running pre-action listener: _resource_record_pre_action 22:53:45 INFO - Running main action method: populate_webroot 22:53:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:45 INFO - '--tppagecycles', 22:53:45 INFO - '7'], 22:53:45 INFO - 'tests': ['tsvgm']}}, 22:53:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:53:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:53:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:53:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['damp', 'tps']}, 22:53:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'tests': ['damp', 'tps']}, 22:53:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['dromaeo_dom']}, 22:53:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore', 22:53:45 INFO - 'tabpaint']}, 22:53:45 INFO - 'other-e10s': {'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore', 22:53:45 INFO - 'tabpaint']}, 22:53:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore', 22:53:45 INFO - 'tabpaint']}, 22:53:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore', 22:53:45 INFO - 'tabpaint']}, 22:53:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore', 22:53:45 INFO - 'tabpaint']}, 22:53:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['a11yr', 22:53:45 INFO - 'ts_paint', 22:53:45 INFO - 'tpaint', 22:53:45 INFO - 'sessionrestore', 22:53:45 INFO - 'sessionrestore_no_auto_restore', 22:53:45 INFO - 'tabpaint']}, 22:53:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['tsvgx', 22:53:45 INFO - 'tsvgr_opacity', 22:53:45 INFO - 'tart', 22:53:45 INFO - 'tscrollx', 22:53:45 INFO - 'cart']}, 22:53:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:53:45 INFO - 'tsvgr_opacity', 22:53:45 INFO - 'tart', 22:53:45 INFO - 'tscrollx', 22:53:45 INFO - 'cart']}, 22:53:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--disable-e10s'], 22:53:45 INFO - 'tests': ['tp5o']}, 22:53:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'tests': ['tp5o']}, 22:53:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--disable-e10s', 22:53:45 INFO - '--xperf_path', 22:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:45 INFO - 'tests': ['tp5n']}, 22:53:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:45 INFO - 'talos_options': ['--xperf_path', 22:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:45 INFO - 'tests': ['tp5n']}}, 22:53:45 INFO - 'talos.zip': {'path': '', 22:53:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:45 INFO - Running post-action listener: _resource_record_post_action 22:53:45 INFO - ##### 22:53:45 INFO - ##### Running create-virtualenv step. 22:53:45 INFO - ##### 22:53:45 INFO - Running pre-action listener: _resource_record_pre_action 22:53:45 INFO - Running main action method: create_virtualenv 22:53:45 INFO - Creating virtualenv /builds/slave/test/build/venv 22:53:45 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 22:53:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:53:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:45 INFO - Using real prefix '/usr' 22:53:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:53:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:48 INFO - Installing pip.................done. 22:53:48 INFO - Return code: 0 22:53:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:53:48 INFO - Using env: {'DISPLAY': ':0', 22:53:48 INFO - 'HOME': '/home/cltbld', 22:53:48 INFO - 'LANG': 'en_US.UTF-8', 22:53:48 INFO - 'LANGUAGE': 'en_US:en', 22:53:48 INFO - 'LOGNAME': 'cltbld', 22:53:48 INFO - 'MAIL': '/var/mail/cltbld', 22:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:48 INFO - 'MOZ_NO_REMOTE': '1', 22:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:48 INFO - 'NO_EM_RESTART': '1', 22:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:48 INFO - 'PWD': '/builds/slave/test', 22:53:48 INFO - 'SHELL': '/bin/bash', 22:53:48 INFO - 'SHLVL': '1', 22:53:48 INFO - 'TERM': 'linux', 22:53:48 INFO - 'TMOUT': '86400', 22:53:48 INFO - 'USER': 'cltbld', 22:53:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:48 INFO - '_': '/tools/buildbot/bin/python'} 22:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:48 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 22:53:48 INFO - Cleaning up... 22:53:48 INFO - Return code: 0 22:53:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:53:48 INFO - Using env: {'DISPLAY': ':0', 22:53:48 INFO - 'HOME': '/home/cltbld', 22:53:48 INFO - 'LANG': 'en_US.UTF-8', 22:53:48 INFO - 'LANGUAGE': 'en_US:en', 22:53:48 INFO - 'LOGNAME': 'cltbld', 22:53:48 INFO - 'MAIL': '/var/mail/cltbld', 22:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:48 INFO - 'MOZ_NO_REMOTE': '1', 22:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:48 INFO - 'NO_EM_RESTART': '1', 22:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:48 INFO - 'PWD': '/builds/slave/test', 22:53:48 INFO - 'SHELL': '/bin/bash', 22:53:48 INFO - 'SHLVL': '1', 22:53:48 INFO - 'TERM': 'linux', 22:53:48 INFO - 'TMOUT': '86400', 22:53:48 INFO - 'USER': 'cltbld', 22:53:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:48 INFO - '_': '/tools/buildbot/bin/python'} 22:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:48 INFO - Downloading/unpacking psutil>=0.7.1 22:53:48 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 22:53:48 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 22:53:48 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 22:53:48 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 22:53:48 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 22:53:48 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 22:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:50 INFO - Installing collected packages: psutil 22:53:50 INFO - Running setup.py install for psutil 22:53:50 INFO - building 'psutil._psutil_linux' extension 22:53:50 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 22:53:50 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 22:53:50 INFO - building 'psutil._psutil_posix' extension 22:53:50 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 22:53:50 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 22:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:50 INFO - Successfully installed psutil 22:53:50 INFO - Cleaning up... 22:53:50 INFO - Return code: 0 22:53:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:53:50 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')]} 22:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:50 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')]} 22:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:50 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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:53:50 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 22:53:50 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 22:53:50 INFO - Using env: {'DISPLAY': ':0', 22:53:50 INFO - 'HOME': '/home/cltbld', 22:53:50 INFO - 'LANG': 'en_US.UTF-8', 22:53:50 INFO - 'LANGUAGE': 'en_US:en', 22:53:50 INFO - 'LOGNAME': 'cltbld', 22:53:50 INFO - 'MAIL': '/var/mail/cltbld', 22:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:50 INFO - 'MOZ_NO_REMOTE': '1', 22:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:50 INFO - 'NO_EM_RESTART': '1', 22:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:50 INFO - 'PWD': '/builds/slave/test', 22:53:50 INFO - 'SHELL': '/bin/bash', 22:53:50 INFO - 'SHLVL': '1', 22:53:50 INFO - 'TERM': 'linux', 22:53:50 INFO - 'TMOUT': '86400', 22:53:50 INFO - 'USER': 'cltbld', 22:53:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:50 INFO - '_': '/tools/buildbot/bin/python'} 22:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:51 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 22:53:51 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 22:53:51 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 22:53:51 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 22:53:51 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 22:53:51 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 22:53:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:53 INFO - Installing collected packages: mozsystemmonitor 22:53:53 INFO - Running setup.py install for mozsystemmonitor 22:53:53 INFO - Successfully installed mozsystemmonitor 22:53:53 INFO - Cleaning up... 22:53:53 INFO - Return code: 0 22:53:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:53:53 INFO - Using env: {'DISPLAY': ':0', 22:53:53 INFO - 'HOME': '/home/cltbld', 22:53:53 INFO - 'LANG': 'en_US.UTF-8', 22:53:53 INFO - 'LANGUAGE': 'en_US:en', 22:53:53 INFO - 'LOGNAME': 'cltbld', 22:53:53 INFO - 'MAIL': '/var/mail/cltbld', 22:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:53 INFO - 'MOZ_NO_REMOTE': '1', 22:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:53 INFO - 'NO_EM_RESTART': '1', 22:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:53 INFO - 'PWD': '/builds/slave/test', 22:53:53 INFO - 'SHELL': '/bin/bash', 22:53:53 INFO - 'SHLVL': '1', 22:53:53 INFO - 'TERM': 'linux', 22:53:53 INFO - 'TMOUT': '86400', 22:53:53 INFO - 'USER': 'cltbld', 22:53:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:53 INFO - '_': '/tools/buildbot/bin/python'} 22:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:53 INFO - Downloading/unpacking blobuploader==1.2.4 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:55 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:53:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 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 22:53:55 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 22:53:56 INFO - Downloading docopt-0.6.1.tar.gz 22:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:56 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:56 INFO - Running setup.py install for blobuploader 22:53:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:53:56 INFO - Running setup.py install for requests 22:53:56 INFO - Running setup.py install for docopt 22:53:56 INFO - Successfully installed blobuploader requests docopt 22:53:56 INFO - Cleaning up... 22:53:56 INFO - Return code: 0 22:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53: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')]} 22:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:53:56 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 22:53:56 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 22:53:56 INFO - Using env: {'DISPLAY': ':0', 22:53:56 INFO - 'HOME': '/home/cltbld', 22:53:56 INFO - 'LANG': 'en_US.UTF-8', 22:53:56 INFO - 'LANGUAGE': 'en_US:en', 22:53:56 INFO - 'LOGNAME': 'cltbld', 22:53:56 INFO - 'MAIL': '/var/mail/cltbld', 22:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:56 INFO - 'MOZ_NO_REMOTE': '1', 22:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:56 INFO - 'NO_EM_RESTART': '1', 22:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:56 INFO - 'PWD': '/builds/slave/test', 22:53:56 INFO - 'SHELL': '/bin/bash', 22:53:56 INFO - 'SHLVL': '1', 22:53:56 INFO - 'TERM': 'linux', 22:53:56 INFO - 'TMOUT': '86400', 22:53:56 INFO - 'USER': 'cltbld', 22:53:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:56 INFO - '_': '/tools/buildbot/bin/python'} 22:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:53:56 INFO - Running setup.py (path:/tmp/pip-H6pQPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:53:56 INFO - Running setup.py (path:/tmp/pip-fcLfIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:53:57 INFO - Running setup.py (path:/tmp/pip-bEJAy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:53:57 INFO - Running setup.py (path:/tmp/pip-2IeJAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:53:57 INFO - Running setup.py (path:/tmp/pip-IceMEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:53:57 INFO - Running setup.py (path:/tmp/pip-QOQRLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:53:57 INFO - Running setup.py (path:/tmp/pip-GfGSXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:53:57 INFO - Running setup.py (path:/tmp/pip-wvdcpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:53:57 INFO - Running setup.py (path:/tmp/pip-rFAwCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:53:57 INFO - Running setup.py (path:/tmp/pip-T4Fteu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:53:57 INFO - Running setup.py (path:/tmp/pip-5fvSkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:53:57 INFO - Running setup.py (path:/tmp/pip-eRAadv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:53:57 INFO - Running setup.py (path:/tmp/pip-0kYsDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:53:57 INFO - Running setup.py (path:/tmp/pip-3Gfhjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:57 INFO - Running setup.py (path:/tmp/pip-Cl0vMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:53:57 INFO - Running setup.py (path:/tmp/pip-aTnpNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:53:58 INFO - Running setup.py (path:/tmp/pip-ex9km5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:53:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:58 INFO - Running setup.py install for manifestparser 22:53:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Running setup.py install for mozcrash 22:53:58 INFO - Running setup.py install for mozdebug 22:53:58 INFO - Running setup.py install for mozdevice 22:53:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Running setup.py install for mozfile 22:53:58 INFO - Running setup.py install for mozhttpd 22:53:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Running setup.py install for mozinfo 22:53:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Running setup.py install for mozInstall 22:53:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:53:58 INFO - Running setup.py install for mozleak 22:53:59 INFO - Running setup.py install for mozlog 22:53:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Running setup.py install for moznetwork 22:53:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Running setup.py install for mozprocess 22:53:59 INFO - Running setup.py install for mozprofile 22:53:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Running setup.py install for mozrunner 22:53:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Running setup.py install for mozscreenshot 22:53:59 INFO - Running setup.py install for moztest 22:53:59 INFO - Running setup.py install for mozversion 22:53:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:53:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:59 INFO - Cleaning up... 22:53:59 INFO - Return code: 0 22:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:53:59 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')]} 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 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')]} 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:53:59 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 22:53:59 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 22:53:59 INFO - Using env: {'DISPLAY': ':0', 22:53:59 INFO - 'HOME': '/home/cltbld', 22:53:59 INFO - 'LANG': 'en_US.UTF-8', 22:53:59 INFO - 'LANGUAGE': 'en_US:en', 22:53:59 INFO - 'LOGNAME': 'cltbld', 22:53:59 INFO - 'MAIL': '/var/mail/cltbld', 22:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:59 INFO - 'MOZ_NO_REMOTE': '1', 22:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:59 INFO - 'NO_EM_RESTART': '1', 22:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:53:59 INFO - 'PWD': '/builds/slave/test', 22:53:59 INFO - 'SHELL': '/bin/bash', 22:53:59 INFO - 'SHLVL': '1', 22:53:59 INFO - 'TERM': 'linux', 22:53:59 INFO - 'TMOUT': '86400', 22:53:59 INFO - 'USER': 'cltbld', 22:53:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:59 INFO - '_': '/tools/buildbot/bin/python'} 22:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:00 INFO - Running setup.py (path:/tmp/pip-VUtTNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:00 INFO - Running setup.py (path:/tmp/pip-sUw_oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:00 INFO - Running setup.py (path:/tmp/pip-63wVzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:00 INFO - Running setup.py (path:/tmp/pip-LPJCXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:00 INFO - Running setup.py (path:/tmp/pip-DDzlL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:00 INFO - Running setup.py (path:/tmp/pip-HQraNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:00 INFO - Running setup.py (path:/tmp/pip-k8S1aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:00 INFO - Running setup.py (path:/tmp/pip-Zc8kOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:00 INFO - Running setup.py (path:/tmp/pip-waxjKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:00 INFO - Running setup.py (path:/tmp/pip-_HPwBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:00 INFO - Running setup.py (path:/tmp/pip-IBu3Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:00 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)) 22:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:00 INFO - Running setup.py (path:/tmp/pip-H9cvvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:01 INFO - Running setup.py (path:/tmp/pip-cVzLDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:01 INFO - Running setup.py (path:/tmp/pip-aTxmj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:01 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)) 22:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:01 INFO - Running setup.py (path:/tmp/pip-T1Ni56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:01 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)) 22:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:01 INFO - Running setup.py (path:/tmp/pip-fRr8ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:01 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)) 22:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:01 INFO - Running setup.py (path:/tmp/pip-jaMIGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 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)) 22:54:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:03 INFO - Downloading blessings-1.6.tar.gz 22:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:03 INFO - Installing collected packages: blessings 22:54:03 INFO - Running setup.py install for blessings 22:54:03 INFO - Successfully installed blessings 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:03 INFO - Reading from file tmpfile_stdout 22:54:03 INFO - Current package versions: 22:54:03 INFO - argparse == 1.2.1 22:54:03 INFO - blessings == 1.6 22:54:03 INFO - blobuploader == 1.2.4 22:54:03 INFO - docopt == 0.6.1 22:54:03 INFO - manifestparser == 1.1 22:54:03 INFO - mozInstall == 1.12 22:54:03 INFO - mozcrash == 0.17 22:54:03 INFO - mozdebug == 0.1 22:54:03 INFO - mozdevice == 0.48 22:54:03 INFO - mozfile == 1.2 22:54:03 INFO - mozhttpd == 0.7 22:54:03 INFO - mozinfo == 0.9 22:54:03 INFO - mozleak == 0.1 22:54:03 INFO - mozlog == 3.1 22:54:03 INFO - moznetwork == 0.27 22:54:03 INFO - mozprocess == 0.22 22:54:03 INFO - mozprofile == 0.28 22:54:03 INFO - mozrunner == 6.11 22:54:03 INFO - mozscreenshot == 0.1 22:54:03 INFO - mozsystemmonitor == 0.0 22:54:03 INFO - moztest == 0.7 22:54:03 INFO - mozversion == 1.4 22:54:03 INFO - psutil == 3.1.1 22:54:03 INFO - requests == 1.2.3 22:54:03 INFO - wsgiref == 0.1.2 22:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54:03 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')]} 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 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')]} 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:54:03 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 22:54:03 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 22:54:03 INFO - Using env: {'DISPLAY': ':0', 22:54:03 INFO - 'HOME': '/home/cltbld', 22:54:03 INFO - 'LANG': 'en_US.UTF-8', 22:54:03 INFO - 'LANGUAGE': 'en_US:en', 22:54:03 INFO - 'LOGNAME': 'cltbld', 22:54:03 INFO - 'MAIL': '/var/mail/cltbld', 22:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:03 INFO - 'MOZ_NO_REMOTE': '1', 22:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:03 INFO - 'NO_EM_RESTART': '1', 22:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:03 INFO - 'PWD': '/builds/slave/test', 22:54:03 INFO - 'SHELL': '/bin/bash', 22:54:03 INFO - 'SHLVL': '1', 22:54:03 INFO - 'TERM': 'linux', 22:54:03 INFO - 'TMOUT': '86400', 22:54:03 INFO - 'USER': 'cltbld', 22:54:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:03 INFO - '_': '/tools/buildbot/bin/python'} 22:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 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)) 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:54:03 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')]} 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 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')]} 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:03 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 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:54:03 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 22:54:03 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 22:54:03 INFO - Using env: {'DISPLAY': ':0', 22:54:03 INFO - 'HOME': '/home/cltbld', 22:54:03 INFO - 'LANG': 'en_US.UTF-8', 22:54:03 INFO - 'LANGUAGE': 'en_US:en', 22:54:03 INFO - 'LOGNAME': 'cltbld', 22:54:03 INFO - 'MAIL': '/var/mail/cltbld', 22:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:03 INFO - 'MOZ_NO_REMOTE': '1', 22:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:03 INFO - 'NO_EM_RESTART': '1', 22:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:03 INFO - 'PWD': '/builds/slave/test', 22:54:03 INFO - 'SHELL': '/bin/bash', 22:54:03 INFO - 'SHLVL': '1', 22:54:03 INFO - 'TERM': 'linux', 22:54:03 INFO - 'TMOUT': '86400', 22:54:03 INFO - 'USER': 'cltbld', 22:54:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:03 INFO - '_': '/tools/buildbot/bin/python'} 22:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:04 INFO - Downloading/unpacking jsonschema 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:05 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 22:54:05 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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:06 INFO - warning: no files found matching '*.txt' 22:54:06 INFO - no previously-included directories found matching 'build' 22:54:06 INFO - no previously-included directories found matching 'dist' 22:54:06 INFO - no previously-included directories found matching '.git*' 22:54:06 INFO - Installing collected packages: jsonschema, functools32 22:54:06 INFO - Running setup.py install for functools32 22:54:06 INFO - warning: no files found matching '*.txt' 22:54:06 INFO - no previously-included directories found matching 'build' 22:54:06 INFO - no previously-included directories found matching 'dist' 22:54:06 INFO - no previously-included directories found matching '.git*' 22:54:06 INFO - Successfully installed jsonschema functools32 22:54:06 INFO - Cleaning up... 22:54:06 INFO - Return code: 0 22:54:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66be6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', '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 22:54: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', 'flake8'] in /builds/slave/test/build 22:54: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 flake8 22:54:06 INFO - Using env: {'DISPLAY': ':0', 22:54:06 INFO - 'HOME': '/home/cltbld', 22:54:06 INFO - 'LANG': 'en_US.UTF-8', 22:54:06 INFO - 'LANGUAGE': 'en_US:en', 22:54:06 INFO - 'LOGNAME': 'cltbld', 22:54:06 INFO - 'MAIL': '/var/mail/cltbld', 22:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:06 INFO - 'MOZ_NO_REMOTE': '1', 22:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:06 INFO - 'NO_EM_RESTART': '1', 22:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:06 INFO - 'PWD': '/builds/slave/test', 22:54:06 INFO - 'SHELL': '/bin/bash', 22:54:06 INFO - 'SHLVL': '1', 22:54:06 INFO - 'TERM': 'linux', 22:54:06 INFO - 'TMOUT': '86400', 22:54:06 INFO - 'USER': 'cltbld', 22:54:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:06 INFO - '_': '/tools/buildbot/bin/python'} 22:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:06 INFO - Downloading/unpacking flake8 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:08 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 22:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:09 INFO - no previously-included directories found matching 'docs/_build' 22:54:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:09 INFO - Running setup.py install for pep8 22:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:09 INFO - no previously-included directories found matching 'docs/_build' 22:54:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:54:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:09 INFO - Cleaning up... 22:54:09 INFO - Return code: 0 22:54:09 INFO - Running post-action listener: _resource_record_post_action 22:54:09 INFO - Running post-action listener: _start_resource_monitoring 22:54:09 INFO - Starting resource monitoring. 22:54:09 INFO - ##### 22:54:09 INFO - ##### Running install step. 22:54:09 INFO - ##### 22:54:09 INFO - Running pre-action listener: _resource_record_pre_action 22:54:09 INFO - Running main action method: install 22:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:54:09 INFO - Reading from file tmpfile_stdout 22:54:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:54:09 INFO - Reading from file tmpfile_stdout 22:54:09 INFO - Output received: 22:54:09 INFO - Usage: mozinstall [options] installer 22:54:09 INFO - Options: 22:54:09 INFO - -h, --help show this help message and exit 22:54:09 INFO - -d DEST, --destination=DEST 22:54:09 INFO - Directory to install application into. [default: 22:54:09 INFO - "/builds/slave/test"] 22:54:09 INFO - --app=APP Application being installed. [default: firefox] 22:54:09 INFO - mkdir: /builds/slave/test/build/application 22:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:54:25 INFO - Reading from file tmpfile_stdout 22:54:25 INFO - Output received: 22:54:25 INFO - /builds/slave/test/build/application/firefox/firefox 22:54:25 INFO - Running post-action listener: _resource_record_post_action 22:54:25 INFO - ##### 22:54:25 INFO - ##### Running run-tests step. 22:54:25 INFO - ##### 22:54:25 INFO - Running pre-action listener: _resource_record_pre_action 22:54:25 INFO - Running main action method: run_tests 22:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:54:25 INFO - Python 2.7.3 22:54:25 INFO - Return code: 0 22:54:25 INFO - grabbing minidump binary from tooltool 22:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:25 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 0x290c410>, '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 0x290d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:54:25 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 22:54:25 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 22:54:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:25 INFO - Return code: 0 22:54:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:54:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:54:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:54:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:54:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:54:26 INFO - Return code: 0 22:54:26 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/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 22:54:26 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/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 22:54:26 INFO - Using env: {'DISPLAY': ':0', 22:54:26 INFO - 'HOME': '/home/cltbld', 22:54:26 INFO - 'LANG': 'en_US.UTF-8', 22:54:26 INFO - 'LANGUAGE': 'en_US:en', 22:54:26 INFO - 'LOGNAME': 'cltbld', 22:54:26 INFO - 'MAIL': '/var/mail/cltbld', 22:54:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:54:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:26 INFO - 'MOZ_NO_REMOTE': '1', 22:54:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:26 INFO - 'NO_EM_RESTART': '1', 22:54:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:26 INFO - 'PWD': '/builds/slave/test', 22:54:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:54:26 INFO - 'SHELL': '/bin/bash', 22:54:26 INFO - 'SHLVL': '1', 22:54:26 INFO - 'TERM': 'linux', 22:54:26 INFO - 'TMOUT': '86400', 22:54:26 INFO - 'USER': 'cltbld', 22:54:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285', 22:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:26 INFO - '_': '/tools/buildbot/bin/python'} 22:54:26 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/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 22:54:26 INFO - mozversion application_buildid: 20160414215914 22:54:26 INFO - mozversion application_changeset: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 22:54:26 INFO - mozversion application_display_name: Nightly 22:54:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:26 INFO - mozversion application_name: Firefox 22:54:26 INFO - mozversion application_remotingname: firefox 22:54:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:54:26 INFO - mozversion application_vendor: Mozilla 22:54:26 INFO - mozversion application_version: 48.0a1 22:54:26 INFO - mozversion platform_buildid: 20160414215914 22:54:26 INFO - mozversion platform_changeset: 5a88d4e4b4e0a7906202a157dd1c30c3dfcd6816 22:54:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:54:26 INFO - mozversion platform_version: 48.0a1 22:54:26 INFO - using testdate: 1460699666 22:54:26 INFO - actual date: 1460699666 22:54:26 INFO - starting webserver on 'localhost:57751' 22:54:26 INFO - SUITE-START | Running 2 tests 22:54:26 INFO - TEST-START | dromaeo_css 22:54:26 INFO - operating with platform_type : linux_ 22:54:26 INFO - Initialising browser for dromaeo_css test... 22:54:26 INFO - TEST-INFO | started process 22274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLblfN4/profile http://localhost:57751/getInfo.html) 22:54:31 INFO - PROCESS | 22274 | __metrics Screen width/height:1600/1200 22:54:31 INFO - PROCESS | 22274 | colorDepth:24 22:54:31 INFO - PROCESS | 22274 | Browser inner width/height: 1024/697 22:54:31 INFO - PROCESS | 22274 | __metrics 22:54:33 ERROR - PROCESS | 22274 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:54:33 INFO - TEST-INFO | 22274: exit 0 22:54:33 INFO - Browser initialized. 22:54:33 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:33 INFO - TEST-INFO | started process 22354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLblfN4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:45 INFO - PROCESS | 22354 | RSS: Main: 154304512 22:54:45 INFO - PROCESS | 22354 | 22:55:37 INFO - PROCESS | 22354 | 1460699737772 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] 22:57:49 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:57751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57751/tests/dromaeo/cssquery-ext.html) 22:57:50 INFO - PROCESS | 22354 | RSS: Main: 237342720 22:57:50 INFO - PROCESS | 22354 | 23:00:52 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:57751/tests/dromaeo/cssquery-ext.html (next: http://localhost:57751/tests/dromaeo/cssquery-jquery.html) 23:00:53 INFO - PROCESS | 22354 | RSS: Main: 245321728 23:00:53 INFO - PROCESS | 22354 | 23:03:55 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:57751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57751/tests/dromaeo/cssquery-mootools.html) 23:03:55 INFO - PROCESS | 22354 | RSS: Main: 248565760 23:03:55 INFO - PROCESS | 22354 | 23:06:58 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:57751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57751/tests/dromaeo/cssquery-prototype.html) 23:06:58 INFO - PROCESS | 22354 | RSS: Main: 238727168 23:06:58 INFO - PROCESS | 22354 | 23:10:01 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:57751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57751/tests/dromaeo/cssquery-yui.html) 23:10:02 INFO - PROCESS | 22354 | RSS: Main: 218529792 23:10:02 INFO - PROCESS | 22354 | 23:13:04 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:57751/tests/dromaeo/cssquery-yui.html (next: http://localhost:57751/tests/dromaeo/cssquery-dojo.html) 23:13:05 INFO - PROCESS | 22354 | RSS: Main: 279080960 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | __start_tp_report 23:13:05 INFO - PROCESS | 22354 | _x_x_mozilla_page_load 23:13:05 INFO - PROCESS | 22354 | _x_x_mozilla_page_load_details 23:13:05 INFO - PROCESS | 22354 | |i|pagename|runs| 23:13:05 INFO - PROCESS | 22354 | |0;dojo.html;2634.657494525711;2701.2301494074195;2711.2815103997445;2724.455108978205;2749.175247425772;4584.472785629654;4651.976740116294;4687.414073240845;4687.601553867921;4717.693349932252;4670.883227919304;4670.972386075058;4711.90576188476;4788.209945359012;4790.425148982118;4217.304144816117;4239.17336119456;4263.722858014235;4289.592488713567;4441.156180325728;4365.345198220277;4411.404460397837;4422.845200417986;4442.533533978918;4451.77741112943;4236;4316.3957046013265;4316.978415107905;4340.97829510852;4352.477702675667;4270.380794784739;4274.529801721808;4306.418633484471;4311.073119279338;4322.783860806947;4291.485021797404;4299.634531064863;4300.397944287803;4301;4343.261645520269;4440.888977775549;4543.5910768031035;4604.424446944132;4613.746243956581;4685.929711054337;4948.529889660476;4966.751662416901;4966.975165124188;4999.8000079996755;5016.3980322361185;4958.851234462936;4987.077390682735;4991.151504244287;4998.800047998076;5025.522575355335;4545.409096817392;4604.953950460519;4633.235516139833;4687.742174180385;4755.286706993978;5000.374953130859;5016;5016.423111342169;5018.723970181675;5090.338256026693;4822.565969062801;4876.073546026315;4879.072976134523;4879.1461494238365;4887.315775791392;4912.729799861042;5021.799128034911;5034.345535080416;5149.073166829931;5168.483151684876;5021.447640759514;5029.1953287473825;5043.5965122790085;5044.646874718808;5102.183650615958;5021.221710634857;5033.798648054037;5036.219385995177;5042.571381432546;5043.495650435;4144.191882582928;4211.578842115825;4211.7472951623;4212.010177608259;4213.220554197484;3710.3877860152775;3722.758020728644;3723.72072094594;3725.8137093145233;3735.7945313008045;4258.254805409041;4363.410939523187;4382.035952090535;4387;4452.799624016927;5023.522765337287;5029.4719054498755;5032.7735251913755;5034.84895453137;5048.3184770056305;4369.890752731207;4373.125374925028;4378.540253273424;4415.66882483815;4418.315161150027;4409.867703968822;4512.954870451254;4514;4544.931826022612;4608.953910460852;4787.952120478821;4790.8323208687525;4792.496787837296;4818.903621927542;4831.98528309059;4987.501249874984;4996.22558503418;5048.368953880765;5048.545630893237;5049.166887463527;4713.2458806590785;4765.237561990065;4788.209945359116;4849.442314133919;4858.392700912386;4864.197407427735;4886.804527818847;4893.045856058035;4898.755062246944;4936.086823937583;4967.329410529533;4967.379077615298;4974.477679843564;4980.775865086008;5019.247112932943;4765.332853400458;4889.413270407574;4938.135826230324;4944.456109827988;4985.177445721561;4802.447718512416;4812.903741925072;4815.518448155157;4833.685810422311;4862.100511405401;4701.130290896195;4753.358296629911;4755.762211889461;4778.617710583215;4799.784009719501;4902.485239049848;4952.083864485082;4954.5540901319055;4967.776450059829;5001.699898006132;4800.0399920016835;4836.709797412166;4838.933905306602;4839;4882.048000639841 23:13:05 INFO - PROCESS | 22354 | |1;ext.html;584.9444302791234;586.7535635033286;600.0459269761076;603.8520562462196;631.0282165465184;33692.66307336926;33800.66199338009;34654.65345346546;34698.61205551781;34930.65069349309;37005;37696.246075078554;37878.621213787854;37882;37913.24173516535;7260.310270524318;7584.431167662434;7770.611469426534;7779.105402878657;9514.619415223417;9838.950805245964;9998.10017098461;9998.800023999516;10001.89998100017;10002.9499852501;9988.650397236099;10095.798084038315;10100.444475553842;10101.949490252538;10110.140638045776;9927.553260103312;9985.350952188084;10003.349782264202;10005.149562287213;10014.799704005953;9888.357256778358;9984.101430871184;9988.700338989842;9990.500474976223;9995;37858.242835143144;38288.61711382878;38365.616343836766;38409.42385864214;38485.42271865924;3165.335279591289;3237.0612522368483;3279.8196099214533;3368.1747971747077;3667.0832291927018;28778.856105719547;28877.85561072202;29202.415951680847;29382.85308573465;29461.85269073641;3546.131197856516;3585.928281434357;3594.658507441789;3671.3758661027423;3721.441783732435;229269;229693;229779.8511007451;230621;230929;52566;53461.73269133629;53643.09925908147;53683.731581342625;53770.193447098325;56530;56556.43443565594;56770;56788.148177777366;56864;14890.627734306729;15371.53885383418;15384.846151538566;15391.153486558347;15407.845921540866;11694;11737.823932641017;11742.58900938463;11745.412729363497;11767.176297659253;17372.218250178772;17524.123793810515;17736.113194340232;17795.288188472576;17812.46562603124;6368.713407896656;6493.415592596689;6498.3826536478955;6543.149390579194;6753;867.1242045534055;912.2929729459722;924.2190349154953;979.0601023017982;1078.9028987391016;26809.329766755596;27389.589156162674;28560.714392855807;28660.713392866222;28735.856320718263;823.3948048184579;1013.0477351289765;1037;1072.4155335342257;1087.037971395321;12766.872331276754;13044.56509783942;13417.597472075853;13440.32798360078;13606.251656158809;319617;323229;325330;325537;325770;48418;49002.50997490051;49019.754901225264;49174.75412622914;49192.754036230304;1084.1164450972433;1180.6103985684874;1253.147859455579;1292.2117508319918;1384.9584512464642;24626.50746985086;26001.35980962629;26156.738432616192;26315.73684263133;26454.470910582066;39026.609733902296;39437.408438874016;39459.40810887896;39539.209215816096;39590.208195835345;219338;226738;226955;227043;227170;31654;34319.31361372808;37105.25789484141;38374.23251535009;38883.2223355537;39234.80382598183;40077.198456030135;40095.19809603733;40675.186496269314;40893.18213635651;32347.95650543682;36631.26737465289;36783.81608091942;37891;38136.809315953244;31547.684523155393;32041.67958320387;32123.196920077185;32381.514277285387;32492.83753581217;31893.521597176525;32836.179095522806;32941.17647058843;35950;37344.81327593345;28293.717062829932;29009;29858.552121717756;31874.6812531881;32069.839650801598;24375.878120609283;24431;24608.384790380383;24719.752802472463;24783 23:13:05 INFO - PROCESS | 22354 | |2;jquery.html;383.72180169377197;390.5216110264925;391.9902002449937;396.50087973632697;399.62036065737556;12603.621891343275;12992.805107923365;15956.521304360858;16717.080560569164;16735.33058677653;15974.76037859433;16081.276342564583;16223.83776162238;16265.91867040663;16325.755113673275;5039.470855560168;5240.266362709223;5290.259363689087;5300.840974770763;5301.284326615915;5215.530602245797;5234.450382709818;5243.737813109348;5258.526732594066;5277.6305658603915;5040.84877453677;5234.973825130869;5239.135542635479;5248.973755131238;5275.973620131894;5195.324607801;5198.92201616976;5220.216967454912;5237.45006774289;5242.3184985951775;4573.291139873291;4678.625709943196;4682.531746825324;4696.3894693689945;4715.7877895494785;11947.522099116024;12566;12596.55912043074;12618.55835045769;20337.389878303675;1888.8583356248198;1938.9903050484656;1981.128303546435;2217.756046834863;2234.6424572068554;9397.389169704016;9467.100625440573;9847.359921605073;9854.408735475823;12576.245425274421;1654.7848779658568;1697.7283634618525;1709.4615196213153;1729.161356741979;1788.1630733434022;69604;70394.29605703929;71203;71653.64173179101;72821.99999999948;10160.390376577281;10243.897561024294;10324.587016519255;10528.684139475828;10598.947005264925;14371.640708982359;14421.42314307416;14431.278436078153;14434.927825361015;14448.638784030483;7242.3843973262865;7289;7318.890216646754;7326.816829579303;7525.510841795266;6752.662366881636;6786.626735529495;6851.280615535297;6863.450923926074;6896.069030680794;4369.890752731144;4444.355568442557;4466.798994045275;4487.461504619401;4565.931511027337;1868.6916658751425;1919.3474218765687;1926.2872737087368;1927.759030121235;1933.1783991803427;778.6262593954933;852.5438890193717;890.7327801659476;902.4269588811021;936.6347124621403;16636.339747435406;16790.83209167917;16930.322787088626;17058.829411705723;17405.390811321544;871.4117970369975;925.5233554719325;931.3061768982017;957.4925289596525;978.5107446276861;9228.26173906086;9409.059094090537;9452.19656329206;9544.093311135432;9593.28050396223;287091;292837;368300;385538;388716;79963.60018199871;83075;83113.58443207745;83949.16050839414;85674.57162714271;977.9217662586976;977.9804403911882;1003.894591067942;1013.9493025348703;1015.8120747661854;15209;15272.541823745305;15453.768193477332;15464.530869567374;15935.840641593899;34002.65997339995;34886.47670284897;34983;35051;35052.474212886314;47814.02324709411;48635.5136448631;48683.513164867894;48821.267680985526;48940.75529622329;7054.188768291507;7374;7386.630668466662;7466.440016998638;7593.810154746176;10424.895751042393;10487.318324308895;10605;10712.678619641423;11145.72135696614;9226.477631190779;9379.765505862408;9522.47626380528;9546.618135274512;9592.76018099553;8595.140485951355;9206.861897071416;9261.768455788659;9386.624535018524;9628.085331893459;9658.323917325719;9669.274804389559;9683.709488715349;9722.9027709722;10052.64815731446;7045.26024767392;7127.358537731629;7199.928000720135;7206.531575447579;7307.926920730724;8425.536595487061;9687.757806054624;9706.417614943126;9714.077162669535;9978.201743860618 23:13:05 INFO - PROCESS | 22354 | |3;mootools.html;1218.1229514749382;1275.9234445933246;1286.4725462560352;1346.596021193642;1789.6599646067239;7420.851582968337;7764.3012128908385;7766.145723970359;7775.766726998192;7780.338671212954;7559.848803023936;7686.9231307686905;7705.152433232354;7715.151333353327;7724.07311122666;1892.1674463236202;2136.9145234190614;2210.602091623507;2216.235398787424;2241.1371621925514;2255.1994042115057;2277.0436416705024;2277.9316620501327;2289.7824706652923;2305.2392710405525;2200.5048864005553;2261.412032871457;2261.9321420357332;2264.230161745006;2264.4904896398343;1868.6729822281047;2107.1992642795717;2174.4129085146924;2177.281497105951;2178.4662757624324;2110.02938648222;2114.9788502114934;2128.744550653916;2129.3718353085724;2194.1552502286577;7651.732189373401;7684.846303073908;7722.6910923563555;7751.689932402697;7755.1469338372735;4414.889627759299;4519.389882365905;4532.592066713979;4556.384888040106;4593.724376537385;3007.248187953012;3031.7726170537076;3034;3068.417000769869;3111.9066428007195;998.5157198758596;1038.8857225705167;1058.8464672622504;1738.1569938579778;1786.6873297173072;10347.586096556128;10397.896021039844;10439.060484556427;10471.3193642413;10477.109445697124;3957.8021098944937;3974.3839704845795;4169.478815148106;4188.727732697365;4263.253930562139;8482.236598706146;8496.702615408554;8530.658773648984;8550.27322677567;8557.058723540405;3886.281038007921;4641.443026836801;4657.394538709946;4684.250519916797;4684.95315046852;4139.482564679415;4247.49030116388;4255.723377980421;4265.936010959838;4275.38006988991;3684.5210122684416;3733.5893051764283;3816.847326106925;3864.14988702485;3923.8822835314986;1232.3037483821613;1252.3425201768962;1260.9306488143056;1272.401971073594;1275.2667216350635;770.2451597434546;858.6694122762781;880.3309484791605;884.8363052835246;887.8801361816202;5193.3767947845745;5211.166213405837;5302.284191634157;5404.621676482687;5477.75350109246;424.5648210584176;432.99567004329555;442.3497458735653;447.2084410593297;449.03681602961467;3585.3367127081574;3720.2001569662652;3810.657040866335;3811.5616704079384;3814.6185381461632;9330.533473326306;9727.9027209727;9834.655787047419;9834.852477212848;9856.950715246378;9734.123928846439;9743.123118919331;9747.56135973883;9754.561044753003;9763.804723905481;7215.49491535598;7350.7427240046345;7443.590602516913;7456.925430745731;7553.848923021619;5230.13702739059;5336.447669217895;5387.919181212364;5399.622026458111;5439.891202175855;9006.144416280444;9028.27773778083;9046.909530904606;9123.270138389045;9123.361364704408;9025.142611451902;9145.77135571616;9154.130357616015;9194;9295.395799273025;5816.138835572576;5848.824535263949;6404.775832845828;6870.27862074475;6948.096747422803;6676.89984650221;6735.528513004043;6745.831354215988;7360.926390736024;7411.221821708643;6778.3221677831825;6985.615791131537;7020.894686579603;7054.682539285642;7108.715651373887;6829.385355318045;6865.0732151160955;6865.691043903136;6865.897011544931;6871.4502839773695;6223.844403889939;6252.343503932204;6281.497480201481;6287.308396076336;6292.685365731787;4547.795349209359;4790.209615413418;4800.279958006327;4876.463589005278;4923.261510773413;4609.423822022247;4787.736674482937;4855.271709243641;4876.341693871424;4894.045661096052 23:13:05 INFO - PROCESS | 22354 | |4;prototype.html;311.07455320421747;314.75291895861756;315.13495454976095;320.25221108711156;321.26109947121614;4999.525045120717;5001.699898006118;5027.723475208862;5050.621203409745;5053.166227572447;4938.888750031241;4958.380202474691;4965.379327584052;4975.4527002029745;4988.301637770715;3730.104774854036;3838.3474809282347;3853.5183102112237;3962.8414863405574;3981.1639555693196;3943.4479172915817;3952.6956104485594;3966.5636779954184;3968.4444177814985;3977.4829272194575;3692.4461330800327;3933.9803300983453;3941.8620348287814;3948.0722030322995;3949.071968087497;3809.2191100824402;3916.647501724844;3916.784576848272;3931.9017024574327;3937.212557488485;3480.3735327641016;3497.883780312925;3512.947305790415;3514.9297014059575;3517.243792584581;4790.257510085942;4791.089692958327;4819.566239038469;4820.39745031871;4824.879378015543;4275.615194632467;4467.084247729208;4501.527339629357;4502.099580083964;4542.977285113587;5218.356217791384;5226.804742008328;5237.3453318335205;5254.737263136828;5257.5005374489365;3742.4573436851506;3744;3746.6815320697774;3748.175401411685;3751.531058617673;5230.450802665703;5479.0959491683825;5526.640768350085;5527.170924361338;5542.722863856831;3816.0459885028745;3818.4272359145793;3833.4441505981476;3833.463315135883;3834.7315687902137;3886.9222615547533;3892.8637497687446;3896.7077469189926;3901.5903330150495;3902.941455878164;4211.599898009684;4432.401625780479;4452.777361131931;4466.151431228056;4471.642268618502;5223.738813059408;5239.554637855748;5271.472852714698;5278.2346559749385;5285.709285989307;1317.9209247445183;1333.2467156056991;1334.4462048250061;1338.5315139701027;1341.4768240386256;834.2908527751484;895.7491902267376;913.127962795542;920.2086205862953;930.7812664023949;4675.976620116878;4693.859184224479;4703.365045718852;4709.505501922317;4715.3869996900185;5410.567154627699;5417.783288668488;5419.430959749248;5424.891502169935;5427.1316589345515;4502.032063106448;4672.57946784791;4698.7578570786045;4706.882327941828;4755.0489902019735;2913.169746622245;2917.3144311086876;2921.561765735114;2941.794074414813;2942.2497263198175;5150.381954165524;5161.2516185152945;5162.6128040397125;5163.586913046947;5171.50870667286;5438.247011952191;5604.159376093537;5612.915806262909;5635;5635.69003704792;5166.767495462638;5168.250603662448;5176.197689358156;5179.922301165486;5221.869453263699;5487.917681234705;5497.175423686479;5497.697626630574;5512.91730624049;5516.475934786189;5057.291979122852;5339.572834173179;5346.625736198429;5356.339534744242;5379.515843574097;5071.492850714899;5142.922856157086;5167.545415927404;5180.456052114474;5182.32629758129;3948.0722030323427;3970.4838371011583;3973.28480873434;3977.5226972763453;3980;5197.974010129925;5479.972600136974;5495.587830912617;5501.834944951658;5506;5292.9735351323;5307.9734601326745;5318.149096144598;5326.174442961347;5327.413984461628;5196;5305.734713264398;5322.121849894879;5325.360956685067;5333.5199832015305;4990.451050384382;5243.895122097613;5247.317848679647;5255.6058295628745;5256.395514515727;5146.974265128651;5333.973330133324;5350.117230656898;5354.812581559782;5371.435999220025;5198.350206224222;5202.791888324576;5206.661566998133;5206.947930520646;5208.765605547684 23:13:05 INFO - PROCESS | 22354 | |5;yui.html;677.61037403493;705.3898377903112;708.1431467923812;775.1628241499182;789.5144486141021;11566.363849988247;11811.291322520654;11868.940655296712;11869.643910682682;11873.881261187396;11634.301941883494;11666.708332291675;11675.065994720424;11675.124365672587;11681.299122052662;636.2428709835281;774.6785084190083;800.895883535141;810.9026916769966;814.9185081491833;799.908010578785;804.8953636027337;807.5962018990505;807.6890397197062;807.7334479621711;853.2363534636496;856.1139220906363;856.3106699107216;856.8200677857658;857.7383897911135;666.2837449741523;829.6930135849744;850.1795767084731;853.4324674091722;853.6713365354383;622.2657264427974;623.3797371615271;623.7941479311817;624.618982420723;624.7157543317779;11401.258918170375;11452.198346115776;11476.655700329004;11477.885221147764;11478.139139564482;11882.524699012029;12255.75488490234;12287.385630718518;12487.50049997999;12530.74938501234;10058.698239052841;10105.797884042351;10142.340747851365;10186.898131018743;10248.74378140545;3334.649861764504;3352.1452029732263;3390.135515443571;3397.5073614325784;3437.9828100859586;46414;46787.766061169816;46898.76550617259;47003.29495057577;47112;9954.153896918699;10353.06822385989;10377.481125943672;10421.895781042092;10455.16358691303;18159;18207.27170913175;18235.635287294444;18299.08504574766;18328.175232114587;6607.209772914598;6774.153230846145;6869.450443964471;6880.139982502187;6944.652767361612;3717.9442308365396;3759.4172903200047;3798.2023775007005;3808.447775072654;3885.96114038856;2907.578401131824;3025.4705426550267;3026.7881248312406;3026.9091927242216;3030.272734543694;508.9872753181126;519.8232600915707;521.116707181324;522.5714913770747;572.8367415286623;480.3899048208825;540.8837100023513;544.1293929712429;547.2229434203441;550.8595308196384;6773.966130169416;6818.2159051708695;6993.89509157363;7016.36852683261;7228.096487939008;505.0857947115732;536.7450461031057;540.2220802045042;541.6046286211088;551.3824516541499;3337.5661164049;3376.206591451007;3443.5351227584456;3461.8096004719478;3527.6119626841028;51302;51894.48105518897;52187.47812521902;52200.738996304775;53586;47860;47890.760546197744;48401;48471;49188.75405622949;43272.56727432685;43455.91617173535;43754.78122609366;43755.78122109369;44061;6390.840228994312;6565.967170164118;6637;6684.398404143651;6829.112215411965;28980;29102.70897291;29956.850215748782;29957.55063674003;30189.547156792225;35512.11219719424;38627.42058869063;38949.805250973564;39211.80394098011;39239.41140882946;9067.410618309788;9274.211692005985;9296.767580810263;9363;9497.620095196391;9309.162175404246;10001.899981000097;10215.540300686338;10269.897301026895;10453.68638940833;9747.902520974983;9840.11438970496;9971.800563988825;10035.598576056876;10400.791984160425;10197.439140847324;10469.162467002468;10567.471626418803;11279.32324060559;11498.022668073307;9813.448503389027;10038.397696138256;10194.490275486345;10503.737406564896;10616.150707943192;9144.817103658022;9146;9200.171984521157;9225.86161207569;9737.707868763948;8846.690365837165;9020.86468702983;9055.773605659911;9095.863562046443;9250.95374523123 23:13:05 INFO - PROCESS | 22354 | __end_tp_report 23:13:05 INFO - PROCESS | 22354 | __start_cc_report 23:13:05 INFO - PROCESS | 22354 | _x_x_mozilla_cycle_collect,948 23:13:05 INFO - PROCESS | 22354 | __end_cc_report 23:13:05 INFO - PROCESS | 22354 | __startTimestamp1460700785107__endTimestamp 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | ------- Summary: start ------- 23:13:05 INFO - PROCESS | 22354 | Number of tests: 6 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | [#0] dojo.html Cycles:165 Average:4635.60 Median:4788.21 stddev:470.11 (9.8%) stddev-sans-first:444.57 23:13:05 INFO - PROCESS | 22354 | Values: 2634.7 2701.2 2711.3 2724.5 2749.2 4584.5 4652.0 4687.4 4687.6 4717.7 4670.9 4671.0 4711.9 4788.2 4790.4 4217.3 4239.2 4263.7 4289.6 4441.2 4365.3 4411.4 4422.8 4442.5 4451.8 4236.0 4316.4 4317.0 4341.0 4352.5 4270.4 4274.5 4306.4 4311.1 4322.8 4291.5 4299.6 4300.4 4301.0 4343.3 4440.9 4543.6 4604.4 4613.7 4685.9 4948.5 4966.8 4967.0 4999.8 5016.4 4958.9 4987.1 4991.2 4998.8 5025.5 4545.4 4605.0 4633.2 4687.7 4755.3 5000.4 5016.0 5016.4 5018.7 5090.3 4822.6 4876.1 4879.1 4879.1 4887.3 4912.7 5021.8 5034.3 5149.1 5168.5 5021.4 5029.2 5043.6 5044.6 5102.2 5021.2 5033.8 5036.2 5042.6 5043.5 4144.2 4211.6 4211.7 4212.0 4213.2 3710.4 3722.8 3723.7 3725.8 3735.8 4258.3 4363.4 4382.0 4387.0 4452.8 5023.5 5029.5 5032.8 5034.8 5048.3 4369.9 4373.1 4378.5 4415.7 4418.3 4409.9 4513.0 4514.0 4544.9 4609.0 4788.0 4790.8 4792.5 4818.9 4832.0 4987.5 4996.2 5048.4 5048.5 5049.2 4713.2 4765.2 4788.2 4849.4 4858.4 4864.2 4886.8 4893.0 4898.8 4936.1 4967.3 4967.4 4974.5 4980.8 5019.2 4765.3 4889.4 4938.1 4944.5 4985.2 4802.4 4812.9 4815.5 4833.7 4862.1 4701.1 4753.4 4755.8 4778.6 4799.8 4902.5 4952.1 4954.6 4967.8 5001.7 4800.0 4836.7 4838.9 4839.0 4882.0 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | [#1] ext.html Cycles:180 Average:42451.30 Median:32888.68 stddev:68821.88 (209.3%) stddev-sans-first:68943.15 23:13:05 INFO - PROCESS | 22354 | Values: 584.9 586.8 600.0 603.9 631.0 33692.7 33800.7 34654.7 34698.6 34930.7 37005.0 37696.2 37878.6 37882.0 37913.2 7260.3 7584.4 7770.6 7779.1 9514.6 9839.0 9998.1 9998.8 10001.9 10002.9 9988.7 10095.8 10100.4 10101.9 10110.1 9927.6 9985.4 10003.3 10005.1 10014.8 9888.4 9984.1 9988.7 9990.5 9995.0 37858.2 38288.6 38365.6 38409.4 38485.4 3165.3 3237.1 3279.8 3368.2 3667.1 28778.9 28877.9 29202.4 29382.9 29461.9 3546.1 3585.9 3594.7 3671.4 3721.4 229269.0 229693.0 229779.9 230621.0 230929.0 52566.0 53461.7 53643.1 53683.7 53770.2 56530.0 56556.4 56770.0 56788.1 56864.0 14890.6 15371.5 15384.8 15391.2 15407.8 11694.0 11737.8 11742.6 11745.4 11767.2 17372.2 17524.1 17736.1 17795.3 17812.5 6368.7 6493.4 6498.4 6543.1 6753.0 867.1 912.3 924.2 979.1 1078.9 26809.3 27389.6 28560.7 28660.7 28735.9 823.4 1013.0 1037.0 1072.4 1087.0 12766.9 13044.6 13417.6 13440.3 13606.3 319617.0 323229.0 325330.0 325537.0 325770.0 48418.0 49002.5 49019.8 49174.8 49192.8 1084.1 1180.6 1253.1 1292.2 1385.0 24626.5 26001.4 26156.7 26315.7 26454.5 39026.6 39437.4 39459.4 39539.2 39590.2 219338.0 226738.0 226955.0 227043.0 227170.0 31654.0 34319.3 37105.3 38374.2 38883.2 39234.8 40077.2 40095.2 40675.2 40893.2 32348.0 36631.3 36783.8 37891.0 38136.8 31547.7 32041.7 32123.2 32381.5 32492.8 31893.5 32836.2 32941.2 35950.0 37344.8 28293.7 29009.0 29858.6 31874.7 32069.8 24375.9 24431.0 24608.4 24719.8 24783.0 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | [#2] jquery.html Cycles:180 Average:22791.59 Median:5040.16 stddev:57930.30 (1149.4%) stddev-sans-first:58068.38 23:13:05 INFO - PROCESS | 22354 | Values: 383.7 390.5 392.0 396.5 399.6 12603.6 12992.8 15956.5 16717.1 16735.3 15974.8 16081.3 16223.8 16265.9 16325.8 5039.5 5240.3 5290.3 5300.8 5301.3 5215.5 5234.5 5243.7 5258.5 5277.6 5040.8 5235.0 5239.1 5249.0 5276.0 5195.3 5198.9 5220.2 5237.5 5242.3 4573.3 4678.6 4682.5 4696.4 4715.8 11947.5 12566.0 12596.6 12618.6 20337.4 1888.9 1939.0 1981.1 2217.8 2234.6 9397.4 9467.1 9847.4 9854.4 12576.2 1654.8 1697.7 1709.5 1729.2 1788.2 69604.0 70394.3 71203.0 71653.6 72822.0 10160.4 10243.9 10324.6 10528.7 10598.9 14371.6 14421.4 14431.3 14434.9 14448.6 7242.4 7289.0 7318.9 7326.8 7525.5 6752.7 6786.6 6851.3 6863.5 6896.1 4369.9 4444.4 4466.8 4487.5 4565.9 1868.7 1919.3 1926.3 1927.8 1933.2 778.6 852.5 890.7 902.4 936.6 16636.3 16790.8 16930.3 17058.8 17405.4 871.4 925.5 931.3 957.5 978.5 9228.3 9409.1 9452.2 9544.1 9593.3 287091.0 292837.0 368300.0 385538.0 388716.0 79963.6 83075.0 83113.6 83949.2 85674.6 977.9 978.0 1003.9 1013.9 1015.8 15209.0 15272.5 15453.8 15464.5 15935.8 34002.7 34886.5 34983.0 35051.0 35052.5 47814.0 48635.5 48683.5 48821.3 48940.8 7054.2 7374.0 7386.6 7466.4 7593.8 10424.9 10487.3 10605.0 10712.7 11145.7 9226.5 9379.8 9522.5 9546.6 9592.8 8595.1 9206.9 9261.8 9386.6 9628.1 9658.3 9669.3 9683.7 9722.9 10052.6 7045.3 7127.4 7199.9 7206.5 7307.9 8425.5 9687.8 9706.4 9714.1 9978.2 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | [#3] mootools.html Cycles:180 Average:5140.15 Median:4876.40 stddev:2847.98 (58.4%) stddev-sans-first:2840.71 23:13:05 INFO - PROCESS | 22354 | Values: 1218.1 1275.9 1286.5 1346.6 1789.7 7420.9 7764.3 7766.1 7775.8 7780.3 7559.8 7686.9 7705.2 7715.2 7724.1 1892.2 2136.9 2210.6 2216.2 2241.1 2255.2 2277.0 2277.9 2289.8 2305.2 2200.5 2261.4 2261.9 2264.2 2264.5 1868.7 2107.2 2174.4 2177.3 2178.5 2110.0 2115.0 2128.7 2129.4 2194.2 7651.7 7684.8 7722.7 7751.7 7755.1 4414.9 4519.4 4532.6 4556.4 4593.7 3007.2 3031.8 3034.0 3068.4 3111.9 998.5 1038.9 1058.8 1738.2 1786.7 10347.6 10397.9 10439.1 10471.3 10477.1 3957.8 3974.4 4169.5 4188.7 4263.3 8482.2 8496.7 8530.7 8550.3 8557.1 3886.3 4641.4 4657.4 4684.3 4685.0 4139.5 4247.5 4255.7 4265.9 4275.4 3684.5 3733.6 3816.8 3864.1 3923.9 1232.3 1252.3 1260.9 1272.4 1275.3 770.2 858.7 880.3 884.8 887.9 5193.4 5211.2 5302.3 5404.6 5477.8 424.6 433.0 442.3 447.2 449.0 3585.3 3720.2 3810.7 3811.6 3814.6 9330.5 9727.9 9834.7 9834.9 9857.0 9734.1 9743.1 9747.6 9754.6 9763.8 7215.5 7350.7 7443.6 7456.9 7553.8 5230.1 5336.4 5387.9 5399.6 5439.9 9006.1 9028.3 9046.9 9123.3 9123.4 9025.1 9145.8 9154.1 9194.0 9295.4 5816.1 5848.8 6404.8 6870.3 6948.1 6676.9 6735.5 6745.8 7360.9 7411.2 6778.3 6985.6 7020.9 7054.7 7108.7 6829.4 6865.1 6865.7 6865.9 6871.5 6223.8 6252.3 6281.5 6287.3 6292.7 4547.8 4790.2 4800.3 4876.5 4923.3 4609.4 4787.7 4855.3 4876.3 4894.0 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | [#4] prototype.html Cycles:180 Average:4391.73 Median:4994.99 stddev:1275.66 (25.5%) stddev-sans-first:1241.92 23:13:05 INFO - PROCESS | 22354 | Values: 311.1 314.8 315.1 320.3 321.3 4999.5 5001.7 5027.7 5050.6 5053.2 4938.9 4958.4 4965.4 4975.5 4988.3 3730.1 3838.3 3853.5 3962.8 3981.2 3943.4 3952.7 3966.6 3968.4 3977.5 3692.4 3934.0 3941.9 3948.1 3949.1 3809.2 3916.6 3916.8 3931.9 3937.2 3480.4 3497.9 3512.9 3514.9 3517.2 4790.3 4791.1 4819.6 4820.4 4824.9 4275.6 4467.1 4501.5 4502.1 4543.0 5218.4 5226.8 5237.3 5254.7 5257.5 3742.5 3744.0 3746.7 3748.2 3751.5 5230.5 5479.1 5526.6 5527.2 5542.7 3816.0 3818.4 3833.4 3833.5 3834.7 3886.9 3892.9 3896.7 3901.6 3902.9 4211.6 4432.4 4452.8 4466.2 4471.6 5223.7 5239.6 5271.5 5278.2 5285.7 1317.9 1333.2 1334.4 1338.5 1341.5 834.3 895.7 913.1 920.2 930.8 4676.0 4693.9 4703.4 4709.5 4715.4 5410.6 5417.8 5419.4 5424.9 5427.1 4502.0 4672.6 4698.8 4706.9 4755.0 2913.2 2917.3 2921.6 2941.8 2942.2 5150.4 5161.3 5162.6 5163.6 5171.5 5438.2 5604.2 5612.9 5635.0 5635.7 5166.8 5168.3 5176.2 5179.9 5221.9 5487.9 5497.2 5497.7 5512.9 5516.5 5057.3 5339.6 5346.6 5356.3 5379.5 5071.5 5142.9 5167.5 5180.5 5182.3 3948.1 3970.5 3973.3 3977.5 3980.0 5198.0 5480.0 5495.6 5501.8 5506.0 5293.0 5308.0 5318.1 5326.2 5327.4 5196.0 5305.7 5322.1 5325.4 5333.5 4990.5 5243.9 5247.3 5255.6 5256.4 5147.0 5334.0 5350.1 5354.8 5371.4 5198.4 5202.8 5206.7 5206.9 5208.8 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - PROCESS | 22354 | [#5] yui.html Cycles:180 Average:12608.20 Median:24185.58 stddev:14724.40 (60.9%) stddev-sans-first:14738.45 23:13:05 INFO - PROCESS | 22354 | Values: 677.6 705.4 708.1 775.2 789.5 11566.4 11811.3 11868.9 11869.6 11873.9 11634.3 11666.7 11675.1 11675.1 11681.3 636.2 774.7 800.9 810.9 814.9 799.9 804.9 807.6 807.7 807.7 853.2 856.1 856.3 856.8 857.7 666.3 829.7 850.2 853.4 853.7 622.3 623.4 623.8 624.6 624.7 11401.3 11452.2 11476.7 11477.9 11478.1 11882.5 12255.8 12287.4 12487.5 12530.7 10058.7 10105.8 10142.3 10186.9 10248.7 3334.6 3352.1 3390.1 3397.5 3438.0 46414.0 46787.8 46898.8 47003.3 47112.0 9954.2 10353.1 10377.5 10421.9 10455.2 18159.0 18207.3 18235.6 18299.1 18328.2 6607.2 6774.2 6869.5 6880.1 6944.7 3717.9 3759.4 3798.2 3808.4 3886.0 2907.6 3025.5 3026.8 3026.9 3030.3 509.0 519.8 521.1 522.6 572.8 480.4 540.9 544.1 547.2 550.9 6774.0 6818.2 6993.9 7016.4 7228.1 505.1 536.7 540.2 541.6 551.4 3337.6 3376.2 3443.5 3461.8 3527.6 51302.0 51894.5 52187.5 52200.7 53586.0 47860.0 47890.8 48401.0 48471.0 49188.8 43272.6 43455.9 43754.8 43755.8 44061.0 6390.8 6566.0 6637.0 6684.4 6829.1 28980.0 29102.7 29956.9 29957.6 30189.5 35512.1 38627.4 38949.8 39211.8 39239.4 9067.4 9274.2 9296.8 9363.0 9497.6 9309.2 10001.9 10215.5 10269.9 10453.7 9747.9 9840.1 9971.8 10035.6 10400.8 10197.4 10469.2 10567.5 11279.3 11498.0 9813.4 10038.4 10194.5 10503.7 10616.2 9144.8 9146.0 9200.2 9225.9 9737.7 8846.7 9020.9 9055.8 9095.9 9251.0 23:13:05 INFO - PROCESS | 22354 | -------- Summary: end -------- 23:13:05 INFO - PROCESS | 22354 | 23:13:05 INFO - TEST-INFO | 22354: exit 0 23:13:05 INFO - TEST-OK | dromaeo_css | took 1119054ms 23:13:05 INFO - TEST-START | kraken 23:13:05 INFO - operating with platform_type : linux_ 23:13:05 INFO - Initialising browser for kraken test... 23:13:05 INFO - TEST-INFO | started process 22533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DIEyn/profile http://localhost:57751/getInfo.html) 23:13:10 INFO - PROCESS | 22533 | __metrics Screen width/height:1600/1200 23:13:10 INFO - PROCESS | 22533 | colorDepth:24 23:13:10 INFO - PROCESS | 22533 | Browser inner width/height: 1024/697 23:13:10 INFO - PROCESS | 22533 | __metrics 23:13:11 ERROR - PROCESS | 22533 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:13:12 INFO - TEST-INFO | 22533: exit 0 23:13:12 INFO - Browser initialized. 23:13:12 INFO - Running cycle 1/1 for kraken test... 23:13:12 INFO - TEST-INFO | started process 22613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7DIEyn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:24 INFO - PROCESS | 22613 | RSS: Main: 154411008 23:13:24 INFO - PROCESS | 22613 | 23:13:26 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57751/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:27 INFO - PROCESS | 22613 | RSS: Main: 209932288 23:13:27 INFO - PROCESS | 22613 | 23:13:30 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57751/tests/kraken/driver.html?testName=audio-dft) 23:13:31 INFO - PROCESS | 22613 | RSS: Main: 194723840 23:13:31 INFO - PROCESS | 22613 | 23:13:34 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57751/tests/kraken/driver.html?testName=audio-fft) 23:13:34 INFO - PROCESS | 22613 | RSS: Main: 265265152 23:13:34 INFO - PROCESS | 22613 | 23:13:36 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57751/tests/kraken/driver.html?testName=audio-oscillator) 23:13:37 INFO - PROCESS | 22613 | RSS: Main: 173322240 23:13:37 INFO - PROCESS | 22613 | 23:13:39 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:40 INFO - PROCESS | 22613 | RSS: Main: 177876992 23:13:40 INFO - PROCESS | 22613 | 23:13:43 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57751/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:44 INFO - PROCESS | 22613 | RSS: Main: 213975040 23:13:44 INFO - PROCESS | 22613 | 23:13:47 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57751/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:48 INFO - PROCESS | 22613 | RSS: Main: 214835200 23:13:48 INFO - PROCESS | 22613 | 23:13:50 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57751/tests/kraken/driver.html?testName=json-parse-financial) 23:13:51 INFO - PROCESS | 22613 | RSS: Main: 214810624 23:13:51 INFO - PROCESS | 22613 | 23:13:53 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:53 INFO - PROCESS | 22613 | RSS: Main: 201908224 23:13:53 INFO - PROCESS | 22613 | 23:13:55 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:56 INFO - PROCESS | 22613 | RSS: Main: 204099584 23:13:56 INFO - PROCESS | 22613 | 23:13:58 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:59 INFO - PROCESS | 22613 | RSS: Main: 219381760 23:13:59 INFO - PROCESS | 22613 | 23:14:01 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:02 INFO - PROCESS | 22613 | RSS: Main: 224346112 23:14:02 INFO - PROCESS | 22613 | 23:14:05 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:06 INFO - PROCESS | 22613 | RSS: Main: 218656768 23:14:06 INFO - PROCESS | 22613 | 23:14:07 INFO - PROCESS | 22613 | Cycle 1(1): loaded http://localhost:57751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57751/tests/kraken/driver.html?testName=ai-astar) 23:14:08 INFO - PROCESS | 22613 | RSS: Main: 281280512 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | __start_tp_report 23:14:08 INFO - PROCESS | 22613 | _x_x_mozilla_page_load 23:14:08 INFO - PROCESS | 22613 | _x_x_mozilla_page_load_details 23:14:08 INFO - PROCESS | 22613 | |i|pagename|runs| 23:14:08 INFO - PROCESS | 22613 | |0;ai-astar;109;111;107;112;111;112;101;111;113;111 23:14:08 INFO - PROCESS | 22613 | |1;audio-beat-detection;157;138;160;188;133;156;155;133;186;133 23:14:08 INFO - PROCESS | 22613 | |2;audio-dft;162;161;160;161;161;162;161;162;160;160 23:14:08 INFO - PROCESS | 22613 | |3;audio-fft;73;73;104;116;75;74;74;124;103;74 23:14:08 INFO - PROCESS | 22613 | |4;audio-oscillator;93;94;155;94;94;93;150;93;94;149 23:14:08 INFO - PROCESS | 22613 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;116 23:14:08 INFO - PROCESS | 22613 | |6;imaging-darkroom;146;145;146;147;146;145;147;146;146;146 23:14:08 INFO - PROCESS | 22613 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 23:14:08 INFO - PROCESS | 22613 | |8;json-parse-financial;67;66;66;76;67;66;65;82;64;64 23:14:08 INFO - PROCESS | 22613 | |9;json-stringify-tinderbox;65;65;64;64;65;64;64;65;65;65 23:14:08 INFO - PROCESS | 22613 | |10;stanford-crypto-aes;86;86;83;83;86;94;85;85;87;86 23:14:08 INFO - PROCESS | 22613 | |11;stanford-crypto-ccm;144;145;138;135;135;137;144;136;168;140 23:14:08 INFO - PROCESS | 22613 | |12;stanford-crypto-pbkdf2;173;171;170;172;173;171;171;169;170;168 23:14:08 INFO - PROCESS | 22613 | |13;stanford-crypto-sha256-iterative;72;71;72;73;73;71;72;71;70;71 23:14:08 INFO - PROCESS | 22613 | __end_tp_report 23:14:08 INFO - PROCESS | 22613 | __start_cc_report 23:14:08 INFO - PROCESS | 22613 | _x_x_mozilla_cycle_collect,1857 23:14:08 INFO - PROCESS | 22613 | __end_cc_report 23:14:08 INFO - PROCESS | 22613 | __startTimestamp1460700848171__endTimestamp 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | ------- Summary: start ------- 23:14:08 INFO - PROCESS | 22613 | Number of tests: 14 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.52 (3.2%) stddev-sans-first:3.72 23:14:08 INFO - PROCESS | 22613 | Values: 109.0 111.0 107.0 112.0 111.0 112.0 101.0 111.0 113.0 111.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:156.50 stddev:20.57 (13.1%) stddev-sans-first:21.79 23:14:08 INFO - PROCESS | 22613 | Values: 157.0 138.0 160.0 188.0 133.0 156.0 155.0 133.0 186.0 133.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 23:14:08 INFO - PROCESS | 22613 | Values: 162.0 161.0 160.0 161.0 161.0 162.0 161.0 162.0 160.0 160.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#3] audio-fft Cycles:10 Average:89.00 Median:73.50 stddev:20.43 (27.8%) stddev-sans-first:20.84 23:14:08 INFO - PROCESS | 22613 | Values: 73.0 73.0 104.0 116.0 75.0 74.0 74.0 124.0 103.0 74.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:93.50 stddev:27.95 (29.9%) stddev-sans-first:28.88 23:14:08 INFO - PROCESS | 22613 | Values: 93.0 94.0 155.0 94.0 94.0 93.0 150.0 93.0 94.0 149.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:14:08 INFO - PROCESS | 22613 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:14:08 INFO - PROCESS | 22613 | Values: 146.0 145.0 146.0 147.0 146.0 145.0 147.0 146.0 146.0 146.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:14:08 INFO - PROCESS | 22613 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:66.50 stddev:5.91 (8.9%) stddev-sans-first:6.25 23:14:08 INFO - PROCESS | 22613 | Values: 67.0 66.0 66.0 76.0 67.0 66.0 65.0 82.0 64.0 64.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 23:14:08 INFO - PROCESS | 22613 | Values: 65.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:3.07 (3.6%) stddev-sans-first:3.26 23:14:08 INFO - PROCESS | 22613 | Values: 86.0 86.0 83.0 83.0 86.0 94.0 85.0 85.0 87.0 86.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:142.00 stddev:9.84 (6.9%) stddev-sans-first:10.42 23:14:08 INFO - PROCESS | 22613 | Values: 144.0 145.0 138.0 135.0 135.0 137.0 144.0 136.0 168.0 140.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:1.62 (0.9%) stddev-sans-first:1.51 23:14:08 INFO - PROCESS | 22613 | Values: 173.0 171.0 170.0 172.0 173.0 171.0 171.0 169.0 170.0 168.0 23:14:08 INFO - PROCESS | 22613 | 23:14:08 INFO - PROCESS | 22613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 23:14:08 INFO - PROCESS | 22613 | Values: 72.0 71.0 72.0 73.0 73.0 71.0 72.0 71.0 70.0 71.0 23:14:08 INFO - PROCESS | 22613 | -------- Summary: end -------- 23:14:08 INFO - PROCESS | 22613 | 23:14:09 INFO - TEST-INFO | 22613: exit 0 23:14:09 INFO - TEST-OK | kraken | took 63357ms 23:14:09 INFO - SUITE-END | took 1182s 23:14:09 INFO - Completed test suite (00:19:42) 23:14:09 INFO - javascript benchmark 23:14:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.657494525711, 2701.2301494074195, 2711.2815103997445, 2724.455108978205, 2749.175247425772, 4584.472785629654, 4651.976740116294, 4687.414073240845, 4687.601553867921, 4717.693349932252, 4670.883227919304, 4670.972386075058, 4711.90576188476, 4788.209945359012, 4790.425148982118, 4217.304144816117, 4239.17336119456, 4263.722858014235, 4289.592488713567, 4441.156180325728, 4365.345198220277, 4411.404460397837, 4422.845200417986, 4442.533533978918, 4451.77741112943, 4236.0, 4316.3957046013265, 4316.978415107905, 4340.97829510852, 4352.477702675667, 4270.380794784739, 4274.529801721808, 4306.418633484471, 4311.073119279338, 4322.783860806947, 4291.485021797404, 4299.634531064863, 4300.397944287803, 4301.0, 4343.261645520269, 4440.888977775549, 4543.5910768031035, 4604.424446944132, 4613.746243956581, 4685.929711054337, 4948.529889660476, 4966.751662416901, 4966.975165124188, 4999.8000079996755, 5016.3980322361185, 4958.851234462936, 4987.077390682735, 4991.151504244287, 4998.800047998076, 5025.522575355335, 4545.409096817392, 4604.953950460519, 4633.235516139833, 4687.742174180385, 4755.286706993978, 5000.374953130859, 5016.0, 5016.423111342169, 5018.723970181675, 5090.338256026693, 4822.565969062801, 4876.073546026315, 4879.072976134523, 4879.1461494238365, 4887.315775791392, 4912.729799861042, 5021.799128034911, 5034.345535080416, 5149.073166829931, 5168.483151684876, 5021.447640759514, 5029.1953287473825, 5043.5965122790085, 5044.646874718808, 5102.183650615958, 5021.221710634857, 5033.798648054037, 5036.219385995177, 5042.571381432546, 5043.495650435, 4144.191882582928, 4211.578842115825, 4211.7472951623, 4212.010177608259, 4213.220554197484, 3710.3877860152775, 3722.758020728644, 3723.72072094594, 3725.8137093145233, 3735.7945313008045, 4258.254805409041, 4363.410939523187, 4382.035952090535, 4387.0, 4452.799624016927, 5023.522765337287, 5029.4719054498755, 5032.7735251913755, 5034.84895453137, 5048.3184770056305, 4369.890752731207, 4373.125374925028, 4378.540253273424, 4415.66882483815, 4418.315161150027, 4409.867703968822, 4512.954870451254, 4514.0, 4544.931826022612, 4608.953910460852, 4787.952120478821, 4790.8323208687525, 4792.496787837296, 4818.903621927542, 4831.98528309059, 4987.501249874984, 4996.22558503418, 5048.368953880765, 5048.545630893237, 5049.166887463527, 4713.2458806590785, 4765.237561990065, 4788.209945359116, 4849.442314133919, 4858.392700912386, 4864.197407427735, 4886.804527818847, 4893.045856058035, 4898.755062246944, 4936.086823937583, 4967.329410529533, 4967.379077615298, 4974.477679843564, 4980.775865086008, 5019.247112932943, 4765.332853400458, 4889.413270407574, 4938.135826230324, 4944.456109827988, 4985.177445721561, 4802.447718512416, 4812.903741925072, 4815.518448155157, 4833.685810422311, 4862.100511405401, 4701.130290896195, 4753.358296629911, 4755.762211889461, 4778.617710583215, 4799.784009719501, 4902.485239049848, 4952.083864485082, 4954.5540901319055, 4967.776450059829, 5001.699898006132, 4800.0399920016835, 4836.709797412166, 4838.933905306602, 4839.0, 4882.048000639841], "value": 4606.946439997948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.9444302791234, 586.7535635033286, 600.0459269761076, 603.8520562462196, 631.0282165465184, 33692.66307336926, 33800.66199338009, 34654.65345346546, 34698.61205551781, 34930.65069349309, 37005.0, 37696.246075078554, 37878.621213787854, 37882.0, 37913.24173516535, 7260.310270524318, 7584.431167662434, 7770.611469426534, 7779.105402878657, 9514.619415223417, 9838.950805245964, 9998.10017098461, 9998.800023999516, 10001.89998100017, 10002.9499852501, 9988.650397236099, 10095.798084038315, 10100.444475553842, 10101.949490252538, 10110.140638045776, 9927.553260103312, 9985.350952188084, 10003.349782264202, 10005.149562287213, 10014.799704005953, 9888.357256778358, 9984.101430871184, 9988.700338989842, 9990.500474976223, 9995.0, 37858.242835143144, 38288.61711382878, 38365.616343836766, 38409.42385864214, 38485.42271865924, 3165.335279591289, 3237.0612522368483, 3279.8196099214533, 3368.1747971747077, 3667.0832291927018, 28778.856105719547, 28877.85561072202, 29202.415951680847, 29382.85308573465, 29461.85269073641, 3546.131197856516, 3585.928281434357, 3594.658507441789, 3671.3758661027423, 3721.441783732435, 229269.0, 229693.0, 229779.8511007451, 230621.0, 230929.0, 52566.0, 53461.73269133629, 53643.09925908147, 53683.731581342625, 53770.193447098325, 56530.0, 56556.43443565594, 56770.0, 56788.148177777366, 56864.0, 14890.627734306729, 15371.53885383418, 15384.846151538566, 15391.153486558347, 15407.845921540866, 11694.0, 11737.823932641017, 11742.58900938463, 11745.412729363497, 11767.176297659253, 17372.218250178772, 17524.123793810515, 17736.113194340232, 17795.288188472576, 17812.46562603124, 6368.713407896656, 6493.415592596689, 6498.3826536478955, 6543.149390579194, 6753.0, 867.1242045534055, 912.2929729459722, 924.2190349154953, 979.0601023017982, 1078.9028987391016, 26809.329766755596, 27389.589156162674, 28560.714392855807, 28660.713392866222, 28735.856320718263, 823.3948048184579, 1013.0477351289765, 1037.0, 1072.4155335342257, 1087.037971395321, 12766.872331276754, 13044.56509783942, 13417.597472075853, 13440.32798360078, 13606.251656158809, 319617.0, 323229.0, 325330.0, 325537.0, 325770.0, 48418.0, 49002.50997490051, 49019.754901225264, 49174.75412622914, 49192.754036230304, 1084.1164450972433, 1180.6103985684874, 1253.147859455579, 1292.2117508319918, 1384.9584512464642, 24626.50746985086, 26001.35980962629, 26156.738432616192, 26315.73684263133, 26454.470910582066, 39026.609733902296, 39437.408438874016, 39459.40810887896, 39539.209215816096, 39590.208195835345, 219338.0, 226738.0, 226955.0, 227043.0, 227170.0, 31654.0, 34319.31361372808, 37105.25789484141, 38374.23251535009, 38883.2223355537, 39234.80382598183, 40077.198456030135, 40095.19809603733, 40675.186496269314, 40893.18213635651, 32347.95650543682, 36631.26737465289, 36783.81608091942, 37891.0, 38136.809315953244, 31547.684523155393, 32041.67958320387, 32123.196920077185, 32381.514277285387, 32492.83753581217, 31893.521597176525, 32836.179095522806, 32941.17647058843, 35950.0, 37344.81327593345, 28293.717062829932, 29009.0, 29858.552121717756, 31874.6812531881, 32069.839650801598, 24375.878120609283, 24431.0, 24608.384790380383, 24719.752802472463, 24783.0], "value": 17698.53192800254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.72180169377197, 390.5216110264925, 391.9902002449937, 396.50087973632697, 399.62036065737556, 12603.621891343275, 12992.805107923365, 15956.521304360858, 16717.080560569164, 16735.33058677653, 15974.76037859433, 16081.276342564583, 16223.83776162238, 16265.91867040663, 16325.755113673275, 5039.470855560168, 5240.266362709223, 5290.259363689087, 5300.840974770763, 5301.284326615915, 5215.530602245797, 5234.450382709818, 5243.737813109348, 5258.526732594066, 5277.6305658603915, 5040.84877453677, 5234.973825130869, 5239.135542635479, 5248.973755131238, 5275.973620131894, 5195.324607801, 5198.92201616976, 5220.216967454912, 5237.45006774289, 5242.3184985951775, 4573.291139873291, 4678.625709943196, 4682.531746825324, 4696.3894693689945, 4715.7877895494785, 11947.522099116024, 12566.0, 12596.55912043074, 12618.55835045769, 20337.389878303675, 1888.8583356248198, 1938.9903050484656, 1981.128303546435, 2217.756046834863, 2234.6424572068554, 9397.389169704016, 9467.100625440573, 9847.359921605073, 9854.408735475823, 12576.245425274421, 1654.7848779658568, 1697.7283634618525, 1709.4615196213153, 1729.161356741979, 1788.1630733434022, 69604.0, 70394.29605703929, 71203.0, 71653.64173179101, 72821.99999999948, 10160.390376577281, 10243.897561024294, 10324.587016519255, 10528.684139475828, 10598.947005264925, 14371.640708982359, 14421.42314307416, 14431.278436078153, 14434.927825361015, 14448.638784030483, 7242.3843973262865, 7289.0, 7318.890216646754, 7326.816829579303, 7525.510841795266, 6752.662366881636, 6786.626735529495, 6851.280615535297, 6863.450923926074, 6896.069030680794, 4369.890752731144, 4444.355568442557, 4466.798994045275, 4487.461504619401, 4565.931511027337, 1868.6916658751425, 1919.3474218765687, 1926.2872737087368, 1927.759030121235, 1933.1783991803427, 778.6262593954933, 852.5438890193717, 890.7327801659476, 902.4269588811021, 936.6347124621403, 16636.339747435406, 16790.83209167917, 16930.322787088626, 17058.829411705723, 17405.390811321544, 871.4117970369975, 925.5233554719325, 931.3061768982017, 957.4925289596525, 978.5107446276861, 9228.26173906086, 9409.059094090537, 9452.19656329206, 9544.093311135432, 9593.28050396223, 287091.0, 292837.0, 368300.0, 385538.0, 388716.0, 79963.60018199871, 83075.0, 83113.58443207745, 83949.16050839414, 85674.57162714271, 977.9217662586976, 977.9804403911882, 1003.894591067942, 1013.9493025348703, 1015.8120747661854, 15209.0, 15272.541823745305, 15453.768193477332, 15464.530869567374, 15935.840641593899, 34002.65997339995, 34886.47670284897, 34983.0, 35051.0, 35052.474212886314, 47814.02324709411, 48635.5136448631, 48683.513164867894, 48821.267680985526, 48940.75529622329, 7054.188768291507, 7374.0, 7386.630668466662, 7466.440016998638, 7593.810154746176, 10424.895751042393, 10487.318324308895, 10605.0, 10712.678619641423, 11145.72135696614, 9226.477631190779, 9379.765505862408, 9522.47626380528, 9546.618135274512, 9592.76018099553, 8595.140485951355, 9206.861897071416, 9261.768455788659, 9386.624535018524, 9628.085331893459, 9658.323917325719, 9669.274804389559, 9683.709488715349, 9722.9027709722, 10052.64815731446, 7045.26024767392, 7127.358537731629, 7199.928000720135, 7206.531575447579, 7307.926920730724, 8425.536595487061, 9687.757806054624, 9706.417614943126, 9714.077162669535, 9978.201743860618], "value": 8011.637866121207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.1229514749382, 1275.9234445933246, 1286.4725462560352, 1346.596021193642, 1789.6599646067239, 7420.851582968337, 7764.3012128908385, 7766.145723970359, 7775.766726998192, 7780.338671212954, 7559.848803023936, 7686.9231307686905, 7705.152433232354, 7715.151333353327, 7724.07311122666, 1892.1674463236202, 2136.9145234190614, 2210.602091623507, 2216.235398787424, 2241.1371621925514, 2255.1994042115057, 2277.0436416705024, 2277.9316620501327, 2289.7824706652923, 2305.2392710405525, 2200.5048864005553, 2261.412032871457, 2261.9321420357332, 2264.230161745006, 2264.4904896398343, 1868.6729822281047, 2107.1992642795717, 2174.4129085146924, 2177.281497105951, 2178.4662757624324, 2110.02938648222, 2114.9788502114934, 2128.744550653916, 2129.3718353085724, 2194.1552502286577, 7651.732189373401, 7684.846303073908, 7722.6910923563555, 7751.689932402697, 7755.1469338372735, 4414.889627759299, 4519.389882365905, 4532.592066713979, 4556.384888040106, 4593.724376537385, 3007.248187953012, 3031.7726170537076, 3034.0, 3068.417000769869, 3111.9066428007195, 998.5157198758596, 1038.8857225705167, 1058.8464672622504, 1738.1569938579778, 1786.6873297173072, 10347.586096556128, 10397.896021039844, 10439.060484556427, 10471.3193642413, 10477.109445697124, 3957.8021098944937, 3974.3839704845795, 4169.478815148106, 4188.727732697365, 4263.253930562139, 8482.236598706146, 8496.702615408554, 8530.658773648984, 8550.27322677567, 8557.058723540405, 3886.281038007921, 4641.443026836801, 4657.394538709946, 4684.250519916797, 4684.95315046852, 4139.482564679415, 4247.49030116388, 4255.723377980421, 4265.936010959838, 4275.38006988991, 3684.5210122684416, 3733.5893051764283, 3816.847326106925, 3864.14988702485, 3923.8822835314986, 1232.3037483821613, 1252.3425201768962, 1260.9306488143056, 1272.401971073594, 1275.2667216350635, 770.2451597434546, 858.6694122762781, 880.3309484791605, 884.8363052835246, 887.8801361816202, 5193.3767947845745, 5211.166213405837, 5302.284191634157, 5404.621676482687, 5477.75350109246, 424.5648210584176, 432.99567004329555, 442.3497458735653, 447.2084410593297, 449.03681602961467, 3585.3367127081574, 3720.2001569662652, 3810.657040866335, 3811.5616704079384, 3814.6185381461632, 9330.533473326306, 9727.9027209727, 9834.655787047419, 9834.852477212848, 9856.950715246378, 9734.123928846439, 9743.123118919331, 9747.56135973883, 9754.561044753003, 9763.804723905481, 7215.49491535598, 7350.7427240046345, 7443.590602516913, 7456.925430745731, 7553.848923021619, 5230.13702739059, 5336.447669217895, 5387.919181212364, 5399.622026458111, 5439.891202175855, 9006.144416280444, 9028.27773778083, 9046.909530904606, 9123.270138389045, 9123.361364704408, 9025.142611451902, 9145.77135571616, 9154.130357616015, 9194.0, 9295.395799273025, 5816.138835572576, 5848.824535263949, 6404.775832845828, 6870.27862074475, 6948.096747422803, 6676.89984650221, 6735.528513004043, 6745.831354215988, 7360.926390736024, 7411.221821708643, 6778.3221677831825, 6985.615791131537, 7020.894686579603, 7054.682539285642, 7108.715651373887, 6829.385355318045, 6865.0732151160955, 6865.691043903136, 6865.897011544931, 6871.4502839773695, 6223.844403889939, 6252.343503932204, 6281.497480201481, 6287.308396076336, 6292.685365731787, 4547.795349209359, 4790.209615413418, 4800.279958006327, 4876.463589005278, 4923.261510773413, 4609.423822022247, 4787.736674482937, 4855.271709243641, 4876.341693871424, 4894.045661096052], "value": 4120.5051864629395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.07455320421747, 314.75291895861756, 315.13495454976095, 320.25221108711156, 321.26109947121614, 4999.525045120717, 5001.699898006118, 5027.723475208862, 5050.621203409745, 5053.166227572447, 4938.888750031241, 4958.380202474691, 4965.379327584052, 4975.4527002029745, 4988.301637770715, 3730.104774854036, 3838.3474809282347, 3853.5183102112237, 3962.8414863405574, 3981.1639555693196, 3943.4479172915817, 3952.6956104485594, 3966.5636779954184, 3968.4444177814985, 3977.4829272194575, 3692.4461330800327, 3933.9803300983453, 3941.8620348287814, 3948.0722030322995, 3949.071968087497, 3809.2191100824402, 3916.647501724844, 3916.784576848272, 3931.9017024574327, 3937.212557488485, 3480.3735327641016, 3497.883780312925, 3512.947305790415, 3514.9297014059575, 3517.243792584581, 4790.257510085942, 4791.089692958327, 4819.566239038469, 4820.39745031871, 4824.879378015543, 4275.615194632467, 4467.084247729208, 4501.527339629357, 4502.099580083964, 4542.977285113587, 5218.356217791384, 5226.804742008328, 5237.3453318335205, 5254.737263136828, 5257.5005374489365, 3742.4573436851506, 3744.0, 3746.6815320697774, 3748.175401411685, 3751.531058617673, 5230.450802665703, 5479.0959491683825, 5526.640768350085, 5527.170924361338, 5542.722863856831, 3816.0459885028745, 3818.4272359145793, 3833.4441505981476, 3833.463315135883, 3834.7315687902137, 3886.9222615547533, 3892.8637497687446, 3896.7077469189926, 3901.5903330150495, 3902.941455878164, 4211.599898009684, 4432.401625780479, 4452.777361131931, 4466.151431228056, 4471.642268618502, 5223.738813059408, 5239.554637855748, 5271.472852714698, 5278.2346559749385, 5285.709285989307, 1317.9209247445183, 1333.2467156056991, 1334.4462048250061, 1338.5315139701027, 1341.4768240386256, 834.2908527751484, 895.7491902267376, 913.127962795542, 920.2086205862953, 930.7812664023949, 4675.976620116878, 4693.859184224479, 4703.365045718852, 4709.505501922317, 4715.3869996900185, 5410.567154627699, 5417.783288668488, 5419.430959749248, 5424.891502169935, 5427.1316589345515, 4502.032063106448, 4672.57946784791, 4698.7578570786045, 4706.882327941828, 4755.0489902019735, 2913.169746622245, 2917.3144311086876, 2921.561765735114, 2941.794074414813, 2942.2497263198175, 5150.381954165524, 5161.2516185152945, 5162.6128040397125, 5163.586913046947, 5171.50870667286, 5438.247011952191, 5604.159376093537, 5612.915806262909, 5635.0, 5635.69003704792, 5166.767495462638, 5168.250603662448, 5176.197689358156, 5179.922301165486, 5221.869453263699, 5487.917681234705, 5497.175423686479, 5497.697626630574, 5512.91730624049, 5516.475934786189, 5057.291979122852, 5339.572834173179, 5346.625736198429, 5356.339534744242, 5379.515843574097, 5071.492850714899, 5142.922856157086, 5167.545415927404, 5180.456052114474, 5182.32629758129, 3948.0722030323427, 3970.4838371011583, 3973.28480873434, 3977.5226972763453, 3980.0, 5197.974010129925, 5479.972600136974, 5495.587830912617, 5501.834944951658, 5506.0, 5292.9735351323, 5307.9734601326745, 5318.149096144598, 5326.174442961347, 5327.413984461628, 5196.0, 5305.734713264398, 5322.121849894879, 5325.360956685067, 5333.5199832015305, 4990.451050384382, 5243.895122097613, 5247.317848679647, 5255.6058295628745, 5256.395514515727, 5146.974265128651, 5333.973330133324, 5350.117230656898, 5354.812581559782, 5371.435999220025, 5198.350206224222, 5202.791888324576, 5206.661566998133, 5206.947930520646, 5208.765605547684], "value": 3986.9148783639325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.61037403493, 705.3898377903112, 708.1431467923812, 775.1628241499182, 789.5144486141021, 11566.363849988247, 11811.291322520654, 11868.940655296712, 11869.643910682682, 11873.881261187396, 11634.301941883494, 11666.708332291675, 11675.065994720424, 11675.124365672587, 11681.299122052662, 636.2428709835281, 774.6785084190083, 800.895883535141, 810.9026916769966, 814.9185081491833, 799.908010578785, 804.8953636027337, 807.5962018990505, 807.6890397197062, 807.7334479621711, 853.2363534636496, 856.1139220906363, 856.3106699107216, 856.8200677857658, 857.7383897911135, 666.2837449741523, 829.6930135849744, 850.1795767084731, 853.4324674091722, 853.6713365354383, 622.2657264427974, 623.3797371615271, 623.7941479311817, 624.618982420723, 624.7157543317779, 11401.258918170375, 11452.198346115776, 11476.655700329004, 11477.885221147764, 11478.139139564482, 11882.524699012029, 12255.75488490234, 12287.385630718518, 12487.50049997999, 12530.74938501234, 10058.698239052841, 10105.797884042351, 10142.340747851365, 10186.898131018743, 10248.74378140545, 3334.649861764504, 3352.1452029732263, 3390.135515443571, 3397.5073614325784, 3437.9828100859586, 46414.0, 46787.766061169816, 46898.76550617259, 47003.29495057577, 47112.0, 9954.153896918699, 10353.06822385989, 10377.481125943672, 10421.895781042092, 10455.16358691303, 18159.0, 18207.27170913175, 18235.635287294444, 18299.08504574766, 18328.175232114587, 6607.209772914598, 6774.153230846145, 6869.450443964471, 6880.139982502187, 6944.652767361612, 3717.9442308365396, 3759.4172903200047, 3798.2023775007005, 3808.447775072654, 3885.96114038856, 2907.578401131824, 3025.4705426550267, 3026.7881248312406, 3026.9091927242216, 3030.272734543694, 508.9872753181126, 519.8232600915707, 521.116707181324, 522.5714913770747, 572.8367415286623, 480.3899048208825, 540.8837100023513, 544.1293929712429, 547.2229434203441, 550.8595308196384, 6773.966130169416, 6818.2159051708695, 6993.89509157363, 7016.36852683261, 7228.096487939008, 505.0857947115732, 536.7450461031057, 540.2220802045042, 541.6046286211088, 551.3824516541499, 3337.5661164049, 3376.206591451007, 3443.5351227584456, 3461.8096004719478, 3527.6119626841028, 51302.0, 51894.48105518897, 52187.47812521902, 52200.738996304775, 53586.0, 47860.0, 47890.760546197744, 48401.0, 48471.0, 49188.75405622949, 43272.56727432685, 43455.91617173535, 43754.78122609366, 43755.78122109369, 44061.0, 6390.840228994312, 6565.967170164118, 6637.0, 6684.398404143651, 6829.112215411965, 28980.0, 29102.70897291, 29956.850215748782, 29957.55063674003, 30189.547156792225, 35512.11219719424, 38627.42058869063, 38949.805250973564, 39211.80394098011, 39239.41140882946, 9067.410618309788, 9274.211692005985, 9296.767580810263, 9363.0, 9497.620095196391, 9309.162175404246, 10001.899981000097, 10215.540300686338, 10269.897301026895, 10453.68638940833, 9747.902520974983, 9840.11438970496, 9971.800563988825, 10035.598576056876, 10400.791984160425, 10197.439140847324, 10469.162467002468, 10567.471626418803, 11279.32324060559, 11498.022668073307, 9813.448503389027, 10038.397696138256, 10194.490275486345, 10503.737406564896, 10616.150707943192, 9144.817103658022, 9146.0, 9200.171984521157, 9225.86161207569, 9737.707868763948, 8846.690365837165, 9020.86468702983, 9055.773605659911, 9095.863562046443, 9250.95374523123], "value": 5757.566177373058, "unit": "score"}], "name": "dromaeo_css", "value": 6287.689253963378, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 107.0, 112.0, 111.0, 112.0, 101.0, 111.0, 113.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 138.0, 160.0, 188.0, 133.0, 156.0, 155.0, 133.0, 186.0, 133.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 104.0, 116.0, 75.0, 74.0, 74.0, 124.0, 103.0, 74.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 155.0, 94.0, 94.0, 93.0, 150.0, 93.0, 94.0, 149.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 76.0, 67.0, 66.0, 65.0, 82.0, 64.0, 64.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 83.0, 83.0, 86.0, 94.0, 85.0, 85.0, 87.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 138.0, 135.0, 135.0, 137.0, 144.0, 136.0, 168.0, 140.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 170.0, 172.0, 173.0, 171.0, 171.0, 169.0, 170.0, 168.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 73.0, 71.0, 72.0, 71.0, 70.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1585.8999999999999, "alertThreshold": 2.0}]} 23:14:09 INFO - Return code: 0 23:14:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:09 ERROR - # TBPL SUCCESS # 23:14:09 INFO - Running post-action listener: _resource_record_post_action 23:14:09 INFO - Running post-run listener: _resource_record_post_run 23:14:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516550656; Read time: 12; Write time: 512124 23:14:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 233455616; Read time: 0; Write time: 336028 23:14:10 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283095040; Read time: 12; Write time: 176096 23:14:10 INFO - Running post-run listener: _upload_blobber_files 23:14:10 INFO - Blob upload gear active. 23:14:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:14:10 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 23:14:10 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'] 23:14:10 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 23:14:10 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:11 INFO - (blobuploader) - INFO - Done attempting. 23:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:12 INFO - (blobuploader) - INFO - Done attempting. 23:14:12 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:12 INFO - Return code: 0 23:14:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:14:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/173daa0dc7621189c7abd451dbc4f9008136d4d1d74c915e5c651055268148a862369be1f753bc9d930f34ce37f3fa97b50908b4ca269fee9300171383e72ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eaae43029f0c923fee980f78f166ef1165bb5d65238155f57773da225a906f35bf24429c7b5ba70e583840f8967487f3619db34ba91db5ce2e967789e33a6713"} 23:14:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:14:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:14:12 INFO - Contents: 23:14:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/173daa0dc7621189c7abd451dbc4f9008136d4d1d74c915e5c651055268148a862369be1f753bc9d930f34ce37f3fa97b50908b4ca269fee9300171383e72ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eaae43029f0c923fee980f78f166ef1165bb5d65238155f57773da225a906f35bf24429c7b5ba70e583840f8967487f3619db34ba91db5ce2e967789e33a6713"} 23:14:12 INFO - Running post-run listener: copy_logs_to_upload_dir 23:14:12 INFO - Copying logs to upload dir... 23:14:12 INFO - mkdir: /builds/slave/test/build/upload/logs 23:14:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.314755 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-14 23:14:11.726674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 23:14:11.731469) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285 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/173daa0dc7621189c7abd451dbc4f9008136d4d1d74c915e5c651055268148a862369be1f753bc9d930f34ce37f3fa97b50908b4ca269fee9300171383e72ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eaae43029f0c923fee980f78f166ef1165bb5d65238155f57773da225a906f35bf24429c7b5ba70e583840f8967487f3619db34ba91db5ce2e967789e33a6713"} build_url:https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/crSeq41JQYOLsuZM17YHPA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/173daa0dc7621189c7abd451dbc4f9008136d4d1d74c915e5c651055268148a862369be1f753bc9d930f34ce37f3fa97b50908b4ca269fee9300171383e72ceb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eaae43029f0c923fee980f78f166ef1165bb5d65238155f57773da225a906f35bf24429c7b5ba70e583840f8967487f3619db34ba91db5ce2e967789e33a6713"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 23:14:11.755714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 23:14:11.756029) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460698569.84840-1474121285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 23:14:11.839865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 23:14:11.840211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 23:14:11.840514) ========= ========= Total master_lag: 0.24 =========