builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1461128249.8 results: success (0) buildid: 20160419210832 builduid: 1d0f0c6917834937bc3e76b49db4c3f4 revision: 7e649f9c72b0dd167b2e11578af012e1261e1232 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.804761) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.805303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.805613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.829246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.829561) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 21:57:30-- 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% 6.66M=0.002s 2016-04-19 21:57:30 (6.66 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.975250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:29.975578) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017626 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.027186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.027803) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e649f9c72b0dd167b2e11578af012e1261e1232 --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 7e649f9c72b0dd167b2e11578af012e1261e1232 --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=516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 21:57:30,609 truncating revision to first 12 chars 2016-04-19 21:57:30,609 Setting DEBUG logging. 2016-04-19 21:57:30,609 attempt 1/10 2016-04-19 21:57:30,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e649f9c72b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 21:57:30,864 unpacking tar archive at: fx-team-7e649f9c72b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.593393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.593744) ========= script_repo_revision: 7e649f9c72b0dd167b2e11578af012e1261e1232 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.594221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.594526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 21:57:30.603407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 30 mins, 4 secs) (at 2016-04-19 21:57:30.603832) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:57:31 INFO - MultiFileLogger online at 20160419 21:57:31 in /builds/slave/test 21:57:31 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 21:57:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:57:31 INFO - {'append_to_log': False, 21:57:31 INFO - 'base_work_dir': '/builds/slave/test', 21:57:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:57:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:57:31 INFO - 'branch': 'Fx-Team-Non-PGO', 21:57:31 INFO - 'buildbot_json_path': 'buildprops.json', 21:57:31 INFO - 'config_files': ('talos/linux_config.py',), 21:57:31 INFO - 'default_actions': ('clobber', 21:57:31 INFO - 'read-buildbot-config', 21:57:31 INFO - 'download-and-extract', 21:57:31 INFO - 'populate-webroot', 21:57:31 INFO - 'create-virtualenv', 21:57:31 INFO - 'install', 21:57:31 INFO - 'run-tests'), 21:57:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:57:31 INFO - 'download_minidump_stackwalk': True, 21:57:31 INFO - 'download_symbols': 'ondemand', 21:57:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:57:31 INFO - 'tooltool.py': '/tools/tooltool.py', 21:57:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:57:31 INFO - '/tools/misc-python/virtualenv.py')}, 21:57:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:57:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:57:31 INFO - 'installer_path': 'installer.exe', 21:57:31 INFO - 'log_level': 'info', 21:57:31 INFO - 'log_name': 'talos', 21:57:31 INFO - 'log_to_console': True, 21:57:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:57:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:57:31 INFO - 'opt_config_files': (), 21:57:31 INFO - 'pip_index': False, 21:57:31 INFO - 'sps_profile': False, 21:57:31 INFO - 'sps_profile_interval': 0, 21:57:31 INFO - 'suite': 'dromaeojs', 21:57:31 INFO - 'system_bits': '32', 21:57:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:57:31 INFO - 'title': 'talos-linux64-ix-061', 21:57:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:57:31 INFO - 'use_talos_json': True, 21:57:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:57:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:57:31 INFO - 'work_dir': 'build'} 21:57:31 INFO - ##### 21:57:31 INFO - ##### Running clobber step. 21:57:31 INFO - ##### 21:57:31 INFO - Running pre-action listener: _resource_record_pre_action 21:57:31 INFO - Running main action method: clobber 21:57:31 INFO - rmtree: /builds/slave/test/build 21:57:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:57:31 INFO - Running post-action listener: _resource_record_post_action 21:57:31 INFO - ##### 21:57:31 INFO - ##### Running read-buildbot-config step. 21:57:31 INFO - ##### 21:57:31 INFO - Running pre-action listener: _resource_record_pre_action 21:57:31 INFO - Running main action method: read_buildbot_config 21:57:31 INFO - Using buildbot properties: 21:57:31 INFO - { 21:57:31 INFO - "project": "", 21:57:31 INFO - "product": "firefox", 21:57:31 INFO - "script_repo_revision": "production", 21:57:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:57:31 INFO - "repository": "", 21:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:57:31 INFO - "buildid": "20160419210832", 21:57:31 INFO - "pgo_build": "False", 21:57:31 INFO - "basedir": "/builds/slave/test", 21:57:31 INFO - "buildnumber": 1678, 21:57:31 INFO - "slavename": "talos-linux64-ix-061", 21:57:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:57:31 INFO - "platform": "ubuntu64_hw", 21:57:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:57:31 INFO - "branch": "fx-team", 21:57:31 INFO - "repo_path": "integration/fx-team", 21:57:31 INFO - "revision": "7e649f9c72b0dd167b2e11578af012e1261e1232", 21:57:31 INFO - "stage_platform": "linux64", 21:57:31 INFO - "builduid": "1d0f0c6917834937bc3e76b49db4c3f4", 21:57:31 INFO - "slavebuilddir": "test" 21:57:31 INFO - } 21:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:57:31 INFO - Running post-action listener: _resource_record_post_action 21:57:31 INFO - ##### 21:57:31 INFO - ##### Running download-and-extract step. 21:57:31 INFO - ##### 21:57:31 INFO - Running pre-action listener: _resource_record_pre_action 21:57:31 INFO - Running main action method: download_and_extract 21:57:31 INFO - mkdir: /builds/slave/test/build/tests 21:57:31 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')]} 21:57:31 INFO - https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:32 INFO - Downloaded 1361 bytes. 21:57:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:57:32 INFO - Using the following test package requirements: 21:57:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:57:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:57:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'jsshell-linux-x86_64.zip'], 21:57:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:57:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:57:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:57:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:57:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:57:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:57:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:57:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:32 INFO - https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:34 INFO - Downloaded 22267191 bytes. 21:57:34 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'] 21:57:34 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 21:57:35 INFO - Return code: 0 21:57:35 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 21:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:35 INFO - https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:37 INFO - Downloaded 22267191 bytes. 21:57:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:57:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:57:38 INFO - Return code: 0 21:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:38 INFO - https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:57:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:57:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:39 INFO - Downloaded 10845952 bytes. 21:57:39 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'] 21:57:39 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 21:57:39 INFO - Return code: 0 21:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:39 INFO - https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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 21:57:44 INFO - Downloaded 54506189 bytes. 21:57:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:57:44 INFO - mkdir: /builds/slave/test/properties 21:57:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:57:44 INFO - Writing to file /builds/slave/test/properties/build_url 21:57:44 INFO - Contents: 21:57:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:57:44 INFO - Running post-action listener: _resource_record_post_action 21:57:44 INFO - Running post-action listener: set_extra_try_arguments 21:57:44 INFO - ##### 21:57:44 INFO - ##### Running populate-webroot step. 21:57:44 INFO - ##### 21:57:44 INFO - Running pre-action listener: _resource_record_pre_action 21:57:44 INFO - Running main action method: populate_webroot 21:57:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:57:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:57:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:57:44 INFO - '--tppagecycles', 21:57:44 INFO - '7'], 21:57:44 INFO - 'tests': ['tsvgm']}}, 21:57:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:57:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:57:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:57:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:57:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:57:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['damp', 'tps']}, 21:57:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'tests': ['damp', 'tps']}, 21:57:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['dromaeo_dom']}, 21:57:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:57:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['a11yr', 21:57:44 INFO - 'ts_paint', 21:57:44 INFO - 'tpaint', 21:57:44 INFO - 'sessionrestore', 21:57:44 INFO - 'sessionrestore_no_auto_restore', 21:57:44 INFO - 'tabpaint']}, 21:57:44 INFO - 'other-e10s': {'tests': ['a11yr', 21:57:44 INFO - 'ts_paint', 21:57:44 INFO - 'tpaint', 21:57:44 INFO - 'sessionrestore', 21:57:44 INFO - 'sessionrestore_no_auto_restore', 21:57:44 INFO - 'tabpaint']}, 21:57:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:57:44 INFO - 'ts_paint', 21:57:44 INFO - 'tpaint', 21:57:44 INFO - 'sessionrestore', 21:57:44 INFO - 'sessionrestore_no_auto_restore', 21:57:44 INFO - 'tabpaint']}, 21:57:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:57:44 INFO - 'ts_paint', 21:57:44 INFO - 'tpaint', 21:57:44 INFO - 'sessionrestore', 21:57:44 INFO - 'sessionrestore_no_auto_restore', 21:57:44 INFO - 'tabpaint']}, 21:57:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['a11yr', 21:57:44 INFO - 'ts_paint', 21:57:44 INFO - 'tpaint', 21:57:44 INFO - 'sessionrestore', 21:57:44 INFO - 'sessionrestore_no_auto_restore', 21:57:44 INFO - 'tabpaint']}, 21:57:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['a11yr', 21:57:44 INFO - 'ts_paint', 21:57:44 INFO - 'tpaint', 21:57:44 INFO - 'sessionrestore', 21:57:44 INFO - 'sessionrestore_no_auto_restore', 21:57:44 INFO - 'tabpaint']}, 21:57:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['tsvgx', 21:57:44 INFO - 'tsvgr_opacity', 21:57:44 INFO - 'tart', 21:57:44 INFO - 'tscrollx', 21:57:44 INFO - 'cart']}, 21:57:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:57:44 INFO - 'tsvgr_opacity', 21:57:44 INFO - 'tart', 21:57:44 INFO - 'tscrollx', 21:57:44 INFO - 'cart']}, 21:57:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'talos_options': ['--disable-e10s'], 21:57:44 INFO - 'tests': ['tp5o']}, 21:57:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'tests': ['tp5o']}, 21:57:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'talos_options': ['--disable-e10s', 21:57:44 INFO - '--xperf_path', 21:57:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:44 INFO - 'tests': ['tp5n']}, 21:57:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:57:44 INFO - 'talos_options': ['--xperf_path', 21:57:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:57:44 INFO - 'tests': ['tp5n']}}, 21:57:44 INFO - 'talos.zip': {'path': '', 21:57:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:57:44 INFO - Running post-action listener: _resource_record_post_action 21:57:44 INFO - ##### 21:57:44 INFO - ##### Running create-virtualenv step. 21:57:44 INFO - ##### 21:57:44 INFO - Running pre-action listener: _resource_record_pre_action 21:57:44 INFO - Running main action method: create_virtualenv 21:57:44 INFO - Creating virtualenv /builds/slave/test/build/venv 21:57:44 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 21:57:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:57:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:57:44 INFO - Using real prefix '/usr' 21:57:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:57:45 INFO - Installing distribute.............................................................................................................................................................................................done. 21:57:47 INFO - Installing pip.................done. 21:57:47 INFO - Return code: 0 21:57:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:57:47 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')]} 21:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:47 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')]} 21:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:47 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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:57:47 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 21:57:47 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 21:57:47 INFO - Using env: {'DISPLAY': ':0', 21:57:47 INFO - 'HOME': '/home/cltbld', 21:57:47 INFO - 'LANG': 'en_US.UTF-8', 21:57:47 INFO - 'LANGUAGE': 'en_US:en', 21:57:47 INFO - 'LOGNAME': 'cltbld', 21:57:47 INFO - 'MAIL': '/var/mail/cltbld', 21:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:47 INFO - 'MOZ_NO_REMOTE': '1', 21:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:47 INFO - 'NO_EM_RESTART': '1', 21:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:47 INFO - 'PWD': '/builds/slave/test', 21:57:47 INFO - 'SHELL': '/bin/bash', 21:57:47 INFO - 'SHLVL': '1', 21:57:47 INFO - 'TERM': 'linux', 21:57:47 INFO - 'TMOUT': '86400', 21:57:47 INFO - 'USER': 'cltbld', 21:57:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:47 INFO - '_': '/tools/buildbot/bin/python'} 21:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:47 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 21:57:47 INFO - Cleaning up... 21:57:47 INFO - Return code: 0 21:57:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:57:47 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')]} 21:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:47 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')]} 21:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:47 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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:57:47 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 21:57:47 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 21:57:47 INFO - Using env: {'DISPLAY': ':0', 21:57:47 INFO - 'HOME': '/home/cltbld', 21:57:47 INFO - 'LANG': 'en_US.UTF-8', 21:57:47 INFO - 'LANGUAGE': 'en_US:en', 21:57:47 INFO - 'LOGNAME': 'cltbld', 21:57:47 INFO - 'MAIL': '/var/mail/cltbld', 21:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:47 INFO - 'MOZ_NO_REMOTE': '1', 21:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:47 INFO - 'NO_EM_RESTART': '1', 21:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:47 INFO - 'PWD': '/builds/slave/test', 21:57:47 INFO - 'SHELL': '/bin/bash', 21:57:47 INFO - 'SHLVL': '1', 21:57:47 INFO - 'TERM': 'linux', 21:57:47 INFO - 'TMOUT': '86400', 21:57:47 INFO - 'USER': 'cltbld', 21:57:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:47 INFO - '_': '/tools/buildbot/bin/python'} 21:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:47 INFO - Downloading/unpacking psutil>=0.7.1 21:57:47 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 21:57:47 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 21:57:47 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 21:57:47 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 21:57:47 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 21:57:47 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 21:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:57:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:49 INFO - Installing collected packages: psutil 21:57:49 INFO - Running setup.py install for psutil 21:57:49 INFO - building 'psutil._psutil_linux' extension 21:57:49 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 21:57: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 21:57:50 INFO - building 'psutil._psutil_posix' extension 21:57: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 21:57: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 21:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:50 INFO - Successfully installed psutil 21:57:50 INFO - Cleaning up... 21:57:50 INFO - Return code: 0 21:57:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:57: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')]} 21:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:57: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 21:57: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 21:57:50 INFO - Using env: {'DISPLAY': ':0', 21:57:50 INFO - 'HOME': '/home/cltbld', 21:57:50 INFO - 'LANG': 'en_US.UTF-8', 21:57:50 INFO - 'LANGUAGE': 'en_US:en', 21:57:50 INFO - 'LOGNAME': 'cltbld', 21:57:50 INFO - 'MAIL': '/var/mail/cltbld', 21:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:50 INFO - 'MOZ_NO_REMOTE': '1', 21:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:50 INFO - 'NO_EM_RESTART': '1', 21:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:50 INFO - 'PWD': '/builds/slave/test', 21:57:50 INFO - 'SHELL': '/bin/bash', 21:57:50 INFO - 'SHLVL': '1', 21:57:50 INFO - 'TERM': 'linux', 21:57:50 INFO - 'TMOUT': '86400', 21:57:50 INFO - 'USER': 'cltbld', 21:57:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:50 INFO - '_': '/tools/buildbot/bin/python'} 21:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:57:50 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 21:57:50 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 21:57:50 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 21:57:50 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 21:57:50 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 21:57:50 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 21:57:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:57:52 INFO - Installing collected packages: mozsystemmonitor 21:57:52 INFO - Running setup.py install for mozsystemmonitor 21:57:52 INFO - Successfully installed mozsystemmonitor 21:57:52 INFO - Cleaning up... 21:57:52 INFO - Return code: 0 21:57:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:57:52 INFO - Using env: {'DISPLAY': ':0', 21:57:52 INFO - 'HOME': '/home/cltbld', 21:57:52 INFO - 'LANG': 'en_US.UTF-8', 21:57:52 INFO - 'LANGUAGE': 'en_US:en', 21:57:52 INFO - 'LOGNAME': 'cltbld', 21:57:52 INFO - 'MAIL': '/var/mail/cltbld', 21:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:52 INFO - 'MOZ_NO_REMOTE': '1', 21:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:52 INFO - 'NO_EM_RESTART': '1', 21:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:52 INFO - 'PWD': '/builds/slave/test', 21:57:52 INFO - 'SHELL': '/bin/bash', 21:57:52 INFO - 'SHLVL': '1', 21:57:52 INFO - 'TERM': 'linux', 21:57:52 INFO - 'TMOUT': '86400', 21:57:52 INFO - 'USER': 'cltbld', 21:57:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:52 INFO - '_': '/tools/buildbot/bin/python'} 21:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:57:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:57:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:55 INFO - Downloading docopt-0.6.1.tar.gz 21:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:57:55 INFO - Installing collected packages: blobuploader, requests, docopt 21:57:55 INFO - Running setup.py install for blobuploader 21:57:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:57:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:57:55 INFO - Running setup.py install for requests 21:57:56 INFO - Running setup.py install for docopt 21:57:56 INFO - Successfully installed blobuploader requests docopt 21:57:56 INFO - Cleaning up... 21:57:56 INFO - Return code: 0 21:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:57: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')]} 21:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:57: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 21:57: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 21:57:56 INFO - Using env: {'DISPLAY': ':0', 21:57:56 INFO - 'HOME': '/home/cltbld', 21:57:56 INFO - 'LANG': 'en_US.UTF-8', 21:57:56 INFO - 'LANGUAGE': 'en_US:en', 21:57:56 INFO - 'LOGNAME': 'cltbld', 21:57:56 INFO - 'MAIL': '/var/mail/cltbld', 21:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:56 INFO - 'MOZ_NO_REMOTE': '1', 21:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:56 INFO - 'NO_EM_RESTART': '1', 21:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:56 INFO - 'PWD': '/builds/slave/test', 21:57:56 INFO - 'SHELL': '/bin/bash', 21:57:56 INFO - 'SHLVL': '1', 21:57:56 INFO - 'TERM': 'linux', 21:57:56 INFO - 'TMOUT': '86400', 21:57:56 INFO - 'USER': 'cltbld', 21:57:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:56 INFO - '_': '/tools/buildbot/bin/python'} 21:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:57:56 INFO - Running setup.py (path:/tmp/pip-GasWxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:57:56 INFO - Running setup.py (path:/tmp/pip-UiGynZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:57:56 INFO - Running setup.py (path:/tmp/pip-UvCAdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:57:56 INFO - Running setup.py (path:/tmp/pip-Bptqiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:57:56 INFO - Running setup.py (path:/tmp/pip-NbbZ_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:57:56 INFO - Running setup.py (path:/tmp/pip-KZV_03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:57:56 INFO - Running setup.py (path:/tmp/pip-BDWCBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:57:56 INFO - Running setup.py (path:/tmp/pip-HGx96C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:57:56 INFO - Running setup.py (path:/tmp/pip-rcTiXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:57:57 INFO - Running setup.py (path:/tmp/pip-y1dDXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:57:57 INFO - Running setup.py (path:/tmp/pip-Ytl2kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:57:57 INFO - Running setup.py (path:/tmp/pip-CH1R9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:57:57 INFO - Running setup.py (path:/tmp/pip-rcLsMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:57:57 INFO - Running setup.py (path:/tmp/pip-gavsoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:57:57 INFO - Running setup.py (path:/tmp/pip-yRWgnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:57:57 INFO - Running setup.py (path:/tmp/pip-_u8tho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:57:57 INFO - Running setup.py (path:/tmp/pip-4_u4jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:57:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:57:57 INFO - Running setup.py install for manifestparser 21:57:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:57:57 INFO - Running setup.py install for mozcrash 21:57:57 INFO - Running setup.py install for mozdebug 21:57:57 INFO - Running setup.py install for mozdevice 21:57:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for mozfile 21:57:58 INFO - Running setup.py install for mozhttpd 21:57:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for mozinfo 21:57:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for mozInstall 21:57:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for mozleak 21:57:58 INFO - Running setup.py install for mozlog 21:57:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for moznetwork 21:57:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for mozprocess 21:57:58 INFO - Running setup.py install for mozprofile 21:57:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:57:58 INFO - Running setup.py install for mozrunner 21:57:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:57:59 INFO - Running setup.py install for mozscreenshot 21:57:59 INFO - Running setup.py install for moztest 21:57:59 INFO - Running setup.py install for mozversion 21:57:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:57:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:57:59 INFO - Cleaning up... 21:57:59 INFO - Return code: 0 21:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:57: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')]} 21:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:57: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 21:57: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 21:57:59 INFO - Using env: {'DISPLAY': ':0', 21:57:59 INFO - 'HOME': '/home/cltbld', 21:57:59 INFO - 'LANG': 'en_US.UTF-8', 21:57:59 INFO - 'LANGUAGE': 'en_US:en', 21:57:59 INFO - 'LOGNAME': 'cltbld', 21:57:59 INFO - 'MAIL': '/var/mail/cltbld', 21:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:59 INFO - 'MOZ_NO_REMOTE': '1', 21:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:59 INFO - 'NO_EM_RESTART': '1', 21:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:59 INFO - 'PWD': '/builds/slave/test', 21:57:59 INFO - 'SHELL': '/bin/bash', 21:57:59 INFO - 'SHLVL': '1', 21:57:59 INFO - 'TERM': 'linux', 21:57:59 INFO - 'TMOUT': '86400', 21:57:59 INFO - 'USER': 'cltbld', 21:57:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:59 INFO - '_': '/tools/buildbot/bin/python'} 21:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:57:59 INFO - Running setup.py (path:/tmp/pip-ZZk8_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:57:59 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)) 21:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:57:59 INFO - Running setup.py (path:/tmp/pip-pXmLuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:57:59 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)) 21:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:57:59 INFO - Running setup.py (path:/tmp/pip-Nlch2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:57:59 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)) 21:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:57:59 INFO - Running setup.py (path:/tmp/pip-AfcEGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:57:59 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)) 21:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:57:59 INFO - Running setup.py (path:/tmp/pip-OhoW6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:57:59 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)) 21:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:57:59 INFO - Running setup.py (path:/tmp/pip-Zuw8q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:58: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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:58:00 INFO - Running setup.py (path:/tmp/pip-74PJJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:58: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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:58:00 INFO - Running setup.py (path:/tmp/pip-oMvfCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:58: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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:58:00 INFO - Running setup.py (path:/tmp/pip-DaAVVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:58: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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:58:00 INFO - Running setup.py (path:/tmp/pip-ArOGay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:58: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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:58:00 INFO - Running setup.py (path:/tmp/pip-XxCu2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:58: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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:58:00 INFO - Running setup.py (path:/tmp/pip-qvzUFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:58:00 INFO - Running setup.py (path:/tmp/pip-g3WP2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:58:00 INFO - Running setup.py (path:/tmp/pip-4SzW_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:58:00 INFO - Running setup.py (path:/tmp/pip-7_rVzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:58:00 INFO - Running setup.py (path:/tmp/pip-Zc6Cwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:58:00 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)) 21:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:58:00 INFO - Running setup.py (path:/tmp/pip-KXLRLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:58:00 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)) 21:58:00 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)) 21:58:00 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)) 21:58:00 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)) 21:58:00 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)) 21:58:00 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)) 21:58:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:58:02 INFO - Downloading blessings-1.6.tar.gz 21:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:58:02 INFO - Installing collected packages: blessings 21:58:02 INFO - Running setup.py install for blessings 21:58:02 INFO - Successfully installed blessings 21:58:02 INFO - Cleaning up... 21:58:02 INFO - Return code: 0 21:58:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:58:03 INFO - Reading from file tmpfile_stdout 21:58:03 INFO - Current package versions: 21:58:03 INFO - argparse == 1.2.1 21:58:03 INFO - blessings == 1.6 21:58:03 INFO - blobuploader == 1.2.4 21:58:03 INFO - docopt == 0.6.1 21:58:03 INFO - manifestparser == 1.1 21:58:03 INFO - mozInstall == 1.12 21:58:03 INFO - mozcrash == 0.17 21:58:03 INFO - mozdebug == 0.1 21:58:03 INFO - mozdevice == 0.48 21:58:03 INFO - mozfile == 1.2 21:58:03 INFO - mozhttpd == 0.7 21:58:03 INFO - mozinfo == 0.9 21:58:03 INFO - mozleak == 0.1 21:58:03 INFO - mozlog == 3.1 21:58:03 INFO - moznetwork == 0.27 21:58:03 INFO - mozprocess == 0.22 21:58:03 INFO - mozprofile == 0.28 21:58:03 INFO - mozrunner == 6.11 21:58:03 INFO - mozscreenshot == 0.1 21:58:03 INFO - mozsystemmonitor == 0.0 21:58:03 INFO - moztest == 0.7 21:58:03 INFO - mozversion == 1.4 21:58:03 INFO - psutil == 3.1.1 21:58:03 INFO - requests == 1.2.3 21:58:03 INFO - wsgiref == 0.1.2 21:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:58: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')]} 21:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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')]} 21:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:58: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 21:58: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 21:58:03 INFO - Using env: {'DISPLAY': ':0', 21:58:03 INFO - 'HOME': '/home/cltbld', 21:58:03 INFO - 'LANG': 'en_US.UTF-8', 21:58:03 INFO - 'LANGUAGE': 'en_US:en', 21:58:03 INFO - 'LOGNAME': 'cltbld', 21:58:03 INFO - 'MAIL': '/var/mail/cltbld', 21:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:03 INFO - 'MOZ_NO_REMOTE': '1', 21:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:03 INFO - 'NO_EM_RESTART': '1', 21:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:58:03 INFO - 'PWD': '/builds/slave/test', 21:58:03 INFO - 'SHELL': '/bin/bash', 21:58:03 INFO - 'SHLVL': '1', 21:58:03 INFO - 'TERM': 'linux', 21:58:03 INFO - 'TMOUT': '86400', 21:58:03 INFO - 'USER': 'cltbld', 21:58:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:03 INFO - '_': '/tools/buildbot/bin/python'} 21:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58: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)) 21:58:03 INFO - Cleaning up... 21:58:03 INFO - Return code: 0 21:58:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:58: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')]} 21:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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')]} 21:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58: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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:58: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 21:58: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 21:58:03 INFO - Using env: {'DISPLAY': ':0', 21:58:03 INFO - 'HOME': '/home/cltbld', 21:58:03 INFO - 'LANG': 'en_US.UTF-8', 21:58:03 INFO - 'LANGUAGE': 'en_US:en', 21:58:03 INFO - 'LOGNAME': 'cltbld', 21:58:03 INFO - 'MAIL': '/var/mail/cltbld', 21:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:03 INFO - 'MOZ_NO_REMOTE': '1', 21:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:03 INFO - 'NO_EM_RESTART': '1', 21:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:58:03 INFO - 'PWD': '/builds/slave/test', 21:58:03 INFO - 'SHELL': '/bin/bash', 21:58:03 INFO - 'SHLVL': '1', 21:58:03 INFO - 'TERM': 'linux', 21:58:03 INFO - 'TMOUT': '86400', 21:58:03 INFO - 'USER': 'cltbld', 21:58:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:03 INFO - '_': '/tools/buildbot/bin/python'} 21:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:03 INFO - Downloading/unpacking jsonschema 21:58:03 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 21:58:03 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 21:58:03 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 21:58:03 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 21:58:03 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 21:58:03 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 21:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:58:05 INFO - Downloading/unpacking functools32 (from jsonschema) 21:58: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 21:58: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 21:58:05 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 21:58:05 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 21:58: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 21:58: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 21:58:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:58:05 INFO - warning: no files found matching '*.txt' 21:58:05 INFO - no previously-included directories found matching 'build' 21:58:05 INFO - no previously-included directories found matching 'dist' 21:58:05 INFO - no previously-included directories found matching '.git*' 21:58:05 INFO - Installing collected packages: jsonschema, functools32 21:58:05 INFO - Running setup.py install for functools32 21:58:05 INFO - warning: no files found matching '*.txt' 21:58:05 INFO - no previously-included directories found matching 'build' 21:58:05 INFO - no previously-included directories found matching 'dist' 21:58:05 INFO - no previously-included directories found matching '.git*' 21:58:05 INFO - Successfully installed jsonschema functools32 21:58:05 INFO - Cleaning up... 21:58:05 INFO - Return code: 0 21:58:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:58:05 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')]} 21:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:05 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')]} 21:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:58:05 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 0x7fc6a5acdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', '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 21:58:05 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 21:58:05 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 21:58:05 INFO - Using env: {'DISPLAY': ':0', 21:58:06 INFO - 'HOME': '/home/cltbld', 21:58:06 INFO - 'LANG': 'en_US.UTF-8', 21:58:06 INFO - 'LANGUAGE': 'en_US:en', 21:58:06 INFO - 'LOGNAME': 'cltbld', 21:58:06 INFO - 'MAIL': '/var/mail/cltbld', 21:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:06 INFO - 'MOZ_NO_REMOTE': '1', 21:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:06 INFO - 'NO_EM_RESTART': '1', 21:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:58:06 INFO - 'PWD': '/builds/slave/test', 21:58:06 INFO - 'SHELL': '/bin/bash', 21:58:06 INFO - 'SHLVL': '1', 21:58:06 INFO - 'TERM': 'linux', 21:58:06 INFO - 'TMOUT': '86400', 21:58:06 INFO - 'USER': 'cltbld', 21:58:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:06 INFO - '_': '/tools/buildbot/bin/python'} 21:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:58:06 INFO - Downloading/unpacking flake8 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:58:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:58:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58: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 21:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:58:08 INFO - no previously-included directories found matching 'docs/_build' 21:58:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:58:08 INFO - Running setup.py install for pep8 21:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:58:08 INFO - no previously-included directories found matching 'docs/_build' 21:58:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:58:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:58:08 INFO - Cleaning up... 21:58:09 INFO - Return code: 0 21:58:09 INFO - Running post-action listener: _resource_record_post_action 21:58:09 INFO - Running post-action listener: _start_resource_monitoring 21:58:09 INFO - Starting resource monitoring. 21:58:09 INFO - ##### 21:58:09 INFO - ##### Running install step. 21:58:09 INFO - ##### 21:58:09 INFO - Running pre-action listener: _resource_record_pre_action 21:58:09 INFO - Running main action method: install 21:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:58:09 INFO - Reading from file tmpfile_stdout 21:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 21:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:58:09 INFO - Reading from file tmpfile_stdout 21:58:09 INFO - Output received: 21:58:09 INFO - Usage: mozinstall [options] installer 21:58:09 INFO - Options: 21:58:09 INFO - -h, --help show this help message and exit 21:58:09 INFO - -d DEST, --destination=DEST 21:58:09 INFO - Directory to install application into. [default: 21:58:09 INFO - "/builds/slave/test"] 21:58:09 INFO - --app=APP Application being installed. [default: firefox] 21:58:09 INFO - mkdir: /builds/slave/test/build/application 21:58: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'] 21:58: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 21:58:25 INFO - Reading from file tmpfile_stdout 21:58:25 INFO - Output received: 21:58:25 INFO - /builds/slave/test/build/application/firefox/firefox 21:58:25 INFO - Running post-action listener: _resource_record_post_action 21:58:25 INFO - ##### 21:58:25 INFO - ##### Running run-tests step. 21:58:25 INFO - ##### 21:58:25 INFO - Running pre-action listener: _resource_record_pre_action 21:58:25 INFO - Running main action method: run_tests 21:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:58:25 INFO - Python 2.7.3 21:58:25 INFO - Return code: 0 21:58:25 INFO - grabbing minidump binary from tooltool 21:58: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')]} 21:58: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 0x1fcf410>, '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 0x1fd0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:58: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 21:58: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 21:58:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:58:25 INFO - Return code: 0 21:58:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:58:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:58:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:58:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:58:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:58:26 INFO - Return code: 0 21:58: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/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:58: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/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 21:58:26 INFO - Using env: {'DISPLAY': ':0', 21:58:26 INFO - 'HOME': '/home/cltbld', 21:58:26 INFO - 'LANG': 'en_US.UTF-8', 21:58:26 INFO - 'LANGUAGE': 'en_US:en', 21:58:26 INFO - 'LOGNAME': 'cltbld', 21:58:26 INFO - 'MAIL': '/var/mail/cltbld', 21:58:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:58:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:58:26 INFO - 'MOZ_NO_REMOTE': '1', 21:58:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:58:26 INFO - 'NO_EM_RESTART': '1', 21:58:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:58:26 INFO - 'PWD': '/builds/slave/test', 21:58:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:58:26 INFO - 'SHELL': '/bin/bash', 21:58:26 INFO - 'SHLVL': '1', 21:58:26 INFO - 'TERM': 'linux', 21:58:26 INFO - 'TMOUT': '86400', 21:58:26 INFO - 'USER': 'cltbld', 21:58:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879', 21:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:58:26 INFO - '_': '/tools/buildbot/bin/python'} 21:58: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/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:58:26 INFO - mozversion application_buildid: 20160419210832 21:58:26 INFO - mozversion application_changeset: 7e649f9c72b0dd167b2e11578af012e1261e1232 21:58:26 INFO - mozversion application_display_name: Nightly 21:58:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:58:26 INFO - mozversion application_name: Firefox 21:58:26 INFO - mozversion application_remotingname: firefox 21:58:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:58:26 INFO - mozversion application_vendor: Mozilla 21:58:26 INFO - mozversion application_version: 48.0a1 21:58:26 INFO - mozversion platform_buildid: 20160419210832 21:58:26 INFO - mozversion platform_changeset: 7e649f9c72b0dd167b2e11578af012e1261e1232 21:58:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:58:26 INFO - mozversion platform_version: 48.0a1 21:58:26 INFO - using testdate: 1461128306 21:58:26 INFO - actual date: 1461128306 21:58:26 INFO - starting webserver on 'localhost:54005' 21:58:26 INFO - SUITE-START | Running 2 tests 21:58:26 INFO - TEST-START | dromaeo_css 21:58:26 INFO - operating with platform_type : linux_ 21:58:26 INFO - Initialising browser for dromaeo_css test... 21:58:26 INFO - TEST-INFO | started process 24362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplD4Nha/profile http://localhost:54005/getInfo.html) 21:58:30 INFO - PROCESS | 24362 | __metrics Screen width/height:1600/1200 21:58:30 INFO - PROCESS | 24362 | colorDepth:24 21:58:30 INFO - PROCESS | 24362 | Browser inner width/height: 1024/697 21:58:30 INFO - PROCESS | 24362 | __metrics 21:58:32 ERROR - PROCESS | 24362 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:58:33 INFO - TEST-INFO | 24362: exit 0 21:58:33 INFO - Browser initialized. 21:58:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:58:33 INFO - TEST-INFO | started process 24444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplD4Nha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:44 INFO - PROCESS | 24444 | RSS: Main: 154693632 21:58:44 INFO - PROCESS | 24444 | 21:59:36 INFO - PROCESS | 24444 | 1461128376466 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:01:48 INFO - PROCESS | 24444 | Cycle 1(1): loaded http://localhost:54005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54005/tests/dromaeo/cssquery-ext.html) 22:01:49 INFO - PROCESS | 24444 | RSS: Main: 262606848 22:01:49 INFO - PROCESS | 24444 | 22:04:51 INFO - PROCESS | 24444 | Cycle 1(1): loaded http://localhost:54005/tests/dromaeo/cssquery-ext.html (next: http://localhost:54005/tests/dromaeo/cssquery-jquery.html) 22:04:52 INFO - PROCESS | 24444 | RSS: Main: 237727744 22:04:52 INFO - PROCESS | 24444 | 22:07:54 INFO - PROCESS | 24444 | Cycle 1(1): loaded http://localhost:54005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54005/tests/dromaeo/cssquery-mootools.html) 22:07:54 INFO - PROCESS | 24444 | RSS: Main: 237723648 22:07:54 INFO - PROCESS | 24444 | 22:10:57 INFO - PROCESS | 24444 | Cycle 1(1): loaded http://localhost:54005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54005/tests/dromaeo/cssquery-prototype.html) 22:10:57 INFO - PROCESS | 24444 | RSS: Main: 229093376 22:10:57 INFO - PROCESS | 24444 | 22:14:00 INFO - PROCESS | 24444 | Cycle 1(1): loaded http://localhost:54005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54005/tests/dromaeo/cssquery-yui.html) 22:14:01 INFO - PROCESS | 24444 | RSS: Main: 215785472 22:14:01 INFO - PROCESS | 24444 | 22:17:03 INFO - PROCESS | 24444 | Cycle 1(1): loaded http://localhost:54005/tests/dromaeo/cssquery-yui.html (next: http://localhost:54005/tests/dromaeo/cssquery-dojo.html) 22:17:04 INFO - PROCESS | 24444 | RSS: Main: 266285056 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | __start_tp_report 22:17:04 INFO - PROCESS | 24444 | _x_x_mozilla_page_load 22:17:04 INFO - PROCESS | 24444 | _x_x_mozilla_page_load_details 22:17:04 INFO - PROCESS | 24444 | |i|pagename|runs| 22:17:04 INFO - PROCESS | 24444 | |0;dojo.html;2582.9354266143346;2645.4180080382307;2653.0449038346205;2660.694020187679;2678.370582913015;4483.574060464259;4539.546045395463;4582.335561343603;4585.954140458594;4586.059857729166;4542.613877820381;4599.080183963204;4601.217792975194;4640.67515273931;4676.321933319667;4245.150969806035;4273.7008409411355;4278.871633850989;4319.589638984307;4335.869923902288;4231.1114665920195;4319.179355922381;4327.5239723630375;4360.10617823347;4379.189849877783;4185.560516145822;4240.173166232586;4283.293256612656;4322.027543802619;4331.7617531035785;4218.177455396169;4253.553376895412;4291.377750226231;4307.267764480046;4318.52496225415;4233.491980962304;4235.174141042498;4241.045764702917;4264.850730224458;4271.466066741657;4402.977985110086;4510.548945105496;4511.142882852248;4560.384348113029;4560.635149188057;4937.851864444036;4963.354763880709;4967.254911763228;4979.57673597741;5007.37407824022;4961.156603377399;4975.004999000214;4989.101961646902;4991.176455884774;5028.195488721787;4468.553144685506;4617.815287388534;4650.162970665279;4653.697509661895;4711.081339138835;5014.974925125351;5033.899322013539;5035.874103147451;5043.167877300278;5080.59355251579;4848.539388758062;4854.538818812207;4855.028994201174;4861.538153875376;4892.143874821963;4721.693089949143;4936.333594964633;4969.453360130383;5017.67385119966;5020.623453241022;4837.395325584302;4852.781624826891;4864.854054378375;4877.463479017305;4900.460949295574;4844.685095468783;4848.733319667382;4848.8302909398;4850.733209673502;4903.828366007173;3973.940390894139;4069.4709687740406;4128.298189307825;4202.915941681149;4216.831326746896;3640.6177351377723;3642.0530662028063;3661.1579336752698;3696.4640127181947;3700.777953322809;4239.660827133822;4265.808038638269;4270.701050926467;4274.658027357804;4313.762743049099;4777.163996300634;4833.564979151894;4840.757962101951;4840.975795121002;4887.682300650517;4252.043290259667;4267.957320426756;4286.635635970977;4306.5262821089655;4310.353446982915;4470.396496472999;4477.328400739915;4479.350494178391;4483.036147228361;4519.932201016987;4511.39096222019;4597.678162528591;4645.094206629675;4685.437747470325;4740.004599034172;4951.950480495149;4957.677750946177;4959.652824302264;4973.154563724248;5025.748712564284;4647.395838540968;4668.369506226378;4688.578027977498;4692.671512994058;4742.478327384054;4690.085433340466;4781.4262288524205;4871.488493708252;4877.487863774394;4908.263760435963;4902.681325713817;4925.679830810986;4928.728919909439;4930.630202734881;4935.851924442272;4774.092922344744;4780.330753694555;4780.4741478436645;4801.351817504732;4835.879103022453;4576.496585375673;4731.84069902876;4768.904621907612;4785.401824771903;4827.034593081327;4670.602998745145;4674.041821426667;4679.461861885927;4687.1328804171335;4728.881777955578;4791.880202994953;4792.2332426811545;4797.136515427256;4798.064377446504;4845.709257444564;4536.795844186953;4703.647226457961;4787.257975013878;4787.640926930564;4790.161721698759 22:17:04 INFO - PROCESS | 24444 | |1;ext.html;576.8384852241371;594.6372712645286;610.5878531990908;615.4430240632228;620.435403782558;26288.86855565722;33226.16934576637;33807.66192338076;33821;33875.983720488395;36368;36544.634553654454;36843;36881.44677829828;37117;7434.628268586576;7638.5798781067015;7686.346660533862;7689.769306920802;7690.038745156856;7755.069391672979;7831.373490120776;7864.606769661523;7884.172161923001;7892.092409372909;7856.2143785621265;7867.921320786805;7930.286274235317;7939.245771651713;7940.40446966477;7782.299593036626;7902;7911;7917.841643167105;7932.484388514728;7735.574543400111;7805.921940780577;7806.453548251625;7812.648430820626;7832.647530861068;37229.25541489155;37591.24817503662;37659;37671.24657506862;37703;2909.7090290970946;3224.3067740435918;3325.866965321384;3341.8329083545727;3591.6049234584175;28150.85924570364;28467.145985620464;29118.41763164746;30068.398632027238;31953.36093278145;3301.669833016679;3303.4549299365576;3345.7323414127054;3363.545921300642;3382.1882748140515;195940.020299899;196141;197388;197649;197998.01000995046;51370;51981.74009130006;52105.739471302404;52189.7390513045;52199;57717.71141144267;59188;59365.40634593599;59366;59429.40570594239;13601.115927464882;13677.589672309847;13707.383167757474;13715.657108572366;13828.516001939885;10372.533236004398;10456.163506919429;10460.738481538023;10470.947645261725;10473.371597704163;17600.91199543994;17875.642487150184;18008.909955450137;18621.534461638566;18644.906775466035;6667.86664266712;6859.9314006860295;6904.585724856424;7000.194977577542;7042.119735033121;881.9426737262057;903.823754367905;943.7263193673758;1000.494750151169;1011.185995273797;24787.13245036415;25251.62122568163;25256.494870102862;25280.747192528208;25291.49417011686;885;986.7172675521794;994.16986816008;1006.5017816181037;1045.038564520643;13591.728165436636;14070.437182512585;14135.363908624136;14355.85644143566;14372.28138593087;331982;341334;342242;342657;343169;41339.37990930139;42337.15325693469;42448.78775606164;42496.57503424926;42528;1119.9664010079712;1161.814109742437;1187.3647598534742;1239.2750241109052;1252.6930901928904;25523.87238063798;27513.862430688518;27851.582226267026;28747;28786.136415907557;40203.798981006075;47278.527214727415;49281.75359123181;49305.50694493153;49462.258066128314;317183;319865;321247;321435;321958;32749.67250327466;33773.66226337705;33833.10919244318;33838.49242261319;33842.830785845916;34471.482927755605;41950.580494195885;46112.30831537463;47037.529624704686;47577;34498.82750586231;34555.65444345625;34754.652453475144;35146.64853351434;35155;33673;33860.83069584735;34094.95430274191;34111.31777364389;34268.82865585756;34278.314433710686;34554.481682774276;34617.480737789454;34639.65360346465;34979.95060148199;29659.851700741357;31551.684483155794;31600.525992109677;31780.682193177774;31858.88493902795;24102.39744006414;24241.63637545403;24371.878140609184;24704.752952470244;24747.62878556787 22:17:04 INFO - PROCESS | 24444 | |2;jquery.html;376.771724179176;378.71049077889796;388.180938220355;393.6240889950098;394.48125714685204;15688.843111568882;16403.507894763145;16512;16523.66952660949;16546.586335341606;14905.701885962275;15975.760363594556;16597.91701041496;16651.50045498634;16666.083365414896;4956.083124621957;5081.79672813087;5110.386753589574;5118.8464346069495;5128.025675121734;3670.5778835433866;5482.533984611293;5837.9124313135335;5854.590178687472;5873.676947767871;5550.417206193352;5776.682282474483;5800.9129863052085;5821.592488525805;5834.912476312858;5701.743421546041;5713.400092990239;5713.771449142029;5728.68492232927;5736.139579063132;3339.8497067632015;3540.291941611688;3543.3090547343277;3546.7871927684423;4762.714237145782;20238.898805506025;20385.898070509702;20492.18031278747;20736.896315518326;20794.792052079436;1850.5743678953916;1875.9062046897736;1924.7786504551875;1968.793276705954;2180.858244214121;12329.5068197272;12360.567380141652;13014.349282535835;13166.407511661999;13584.524541641094;1779.635174789178;1803.9549011274692;1860.5255659806662;1862.7205919112241;1884.1897983866932;65873.34126658768;70079.64960175166;70415;70527;70911;9500.762480938032;9752.21982241419;9771.169450596637;10031.197504199647;10136.645217417356;13545.39045742944;13641.113327633871;13654.249016304198;13663.111897726616;13726.86273137256;7250.347468727839;7344.522606030591;7384.556926584422;7492.812679682943;7499.287567681062;6978.267281935425;6996.755113571001;7014.5440546364325;7079.185893622196;7128.073350464407;6065.848353791191;6207.34822843604;6224.595401298901;6225.533085018642;6241.812745617639;1618.708632446171;1721.4577408116404;1764.4886675515888;1767.454864994404;1815.5370380552874;809.8258874342044;898.7842917699705;934.5934518484481;960.3805545423163;1025.876894772632;15796.684066318609;16598;17204.31182752701;17237.655246894992;17666.823331766776;850.2730165708354;854.769212312672;884.5046773806689;898.3217670658611;934.5747684803398;9213.30900182489;9622.711318660451;9984.35101718386;9984.950075249577;9994.10053095225;423124;424378;425666;425847;429201;75556;80580;83812.58093709493;83918.58040709757;84795.57602212073;969.7090872738291;969.7187815533557;973.8003709239589;1006.441425009127;1020.3673722292226;15171.468998584996;15427.151506667242;15662.608434789221;15731.764023539426;15976.840231597535;34747;35050.298994020486;35995.640043599225;36325.09187270339;36657;47514.28728569005;48443.51556484531;49879.750601246764;50248.74875625598;51097;7719.498232614862;7756.565035468457;7803.453758236869;7804.141544429995;7944.960275198587;6665.600063996176;8614.13883542596;10158.796824063329;10403.94798026005;11309.660710178709;6038.365971572922;8566.657333706582;10102.848457273;10105.494725263854;10351.741206469898;9799.412035277906;9897.208223342259;10145.797084058426;10217.33587316822;10443.582256709646;10344.224183186141;10562.735931601772;10568.84146737815;10663.306885052447;10915.945420272848;6380.808575742735;6650.700718467584;6797.524173307821;7590.7722768317035;7657.923420765721;9112;9597.376170548892;10362.481875906326;10483.213758967955;10577.31247468912 22:17:04 INFO - PROCESS | 24444 | |3;mootools.html;1285.5372066056225;1459.3651761483752;1479.8446163152869;1638.680457310824;1798.496421002119;7009.719611215552;7743.6128193590375;7958.124606293318;7969.999999999993;7982.960085199566;7703.191164927686;7836.568988705619;7868.4098692598145;7873.842523149534;7884.724034658788;1907.7901430842596;1983.2860170338668;1984.9702254466195;2244.551089782042;2272.6477396003647;2006.3278801601407;2234.329701089675;2314.375118717945;2315.30540837748;2319.895604697784;2150.731158605174;2175.8912054397215;2176.6408542590534;2178.8583742056794;2187.6937228787983;1831.9816801832078;2126.6384714598557;2128.0742876848544;2128.819050380712;2131.6269652810697;2194.36363454598;2292.610256256424;2297.0467256088705;2298.0118549023914;2306.4925716342377;7770.0287464067;7831.451798374116;7864.095629002623;7864.842703145905;7868.567228802413;4560.065186636732;4710.411198600175;4710.693804902705;4716.976415117937;4722.834700785456;2875.324298789783;2945.072302224792;3022.259546411143;3034.1959380764115;3044.2389402649337;903.7559858838142;934.6121359635811;942.0955882352949;942.8632848237036;948.170350942925;10735.141188704885;10940.070094042016;10958.616448424347;10990.340579565252;10994.780104397947;4060.39094135882;4249.043965107826;4251.851185208503;4266.637335826427;4289.335153051282;9398.389104708172;9423.952880235693;9431.717048488556;9438.764030899145;9455;4745.406824146981;4759.881002974953;4762.380890484214;4763.523647635208;4764.2615394613895;4205.9789701051295;4254.680898932593;4301.376300436419;4319.2009478246;4362.345648152803;3661.1213308806227;3670.5595328560744;3759.3233218020473;3785.734998550075;3805.60041195676;1228.0728050322127;1241.273854794937;1241.6709571963436;1241.8447694038246;1261.7098067444356;829.9004119505698;870.9418057060701;875.2123089219754;895.7312806158257;917.5366439947784;5519.668819870821;5589.469000444951;5675.574331925122;5687.544996400278;5870.383609721003;829.672279449614;843.4985725408782;859.8925134358205;866.8959724833061;941.2281928818303;3686.6866316362875;3847.7306588539095;3848.730588858753;3853.0560012797046;3899.727019108692;9759.65841195569;10078;10158.238132139972;10175.28772985884;10284.434356110485;9988.800223995479;10008.39949603026;10158.949205253926;10176.847347289797;10197.592096316213;7303;7473.476856620093;7497.437692173109;7550.433717471212;7631;5213.452587478412;5229.816956406507;5271.341082364705;5373.919391209057;5411.431799660979;9183.586738596912;9234.584443700183;9237.491937943478;9263.814723705353;9313.580888859882;8109.39179561547;8446.408751387344;8600.569971501525;8976.28189744832;9051.230645395215;7416.6291685414435;7506.812329691801;7526.623668816646;7556.4710470266555;7578.924210757822;7246.89129663045;7399.889001664872;7581.469297149147;7599.886001709868;7605.087389513294;7058.576485410892;7064;7154.213036566078;7168.211496735251;7254.492185546961;6866.34769696878;6872.931270687229;6918.619475928872;6955.339242771928;7046.859062818818;6145.907811382744;6357.745690172342;6541.149650545399;6657.500687448364;6680.766173183915;4790.353302304145;4912.381784948019;4916.410030796327;4927.187014142626;4941.481144479922;5012.223105418666;5024.698518088926;5085.821996230115;5097.057044446789;5099.26060721186 22:17:04 INFO - PROCESS | 24444 | |4;prototype.html;314.33518109199053;319.436195115621;321.7811887916217;327.5463483075939;328.5777775558408;4792.760361981905;4959.305697202394;4971.651984361096;4979.7510124493765;4994.7003179809235;4710.835120770774;4909.9263511047275;4919.778609962551;4941.654084214107;4959.206526955688;3925.430812532188;3941.8620348287814;3950.091478959841;3952.9407058893994;3955.624215699504;3684.778913265213;3788.924221515568;3927.253821773854;3945.3095708251085;3948.13141108957;3917.6865850732015;3920.3335432976464;3921.450996860442;3923.1761330120567;3936.1734035852505;3892.47451594034;3896.7856767877756;3903.6877049835944;3905.863294784669;3938.6258305460933;3463.757536972413;3483.3555792178277;3483.372992861284;3484.372812893678;3498.7725797823314;4573.285018118206;4791.448983366922;4807.807687692488;4814.66297359185;4829.9275510867365;4334.566543345672;4354.891127721832;4372.27857403528;4376.146651402978;4379.956200437987;5184.9740751296;5205.297284866532;5214.374275086976;5216.165413533817;5222.2427747976335;3555.768875023115;3685.5024571682748;3685.7051435885332;3696.2053158570766;3702.500162478058;5392.56859451243;5403.2705584745945;5420.4850539198715;5444.7822087116465;5452.6183167178315;3784.110733977513;3793.3551296279697;3799.430085487144;3806.6764325032127;3806.980965095212;3616.65641764032;3818.541774986964;3843.9039024024623;3852.5376954765047;3854.2291541691775;4363.978180109143;4388.385626012361;4394.36281739146;4394.472663280427;4398.252297109499;5199.428062913076;5199.480051994846;5212.713300768418;5216.452272511332;5216.608754343363;1245.906557008228;1293.2693028438903;1325.4631874091008;1338.4244774746758;1341.2690083904101;896.7758060484879;901.9774505637412;915.1169121797498;917.8439665256923;920.9033051529627;4571.337156112411;4589.242774942097;4589.701669391479;4598.448186217675;4599.1721490132095;5342.412334643186;5344.679319240858;5345.171498417673;5346.572274218053;5351.732413379315;4455.710378825366;4573.199690054227;4575.336576196433;4584.289435137559;4584.862454126382;2818.2672505148807;2824.5904343870434;2834.3906060197155;2834.67401248859;2838.701936296659;5004.3494345734825;5039.118154322979;5046.873828154252;5048.419431765321;5054;5182.382896637249;5360.812371566976;5383.327084114486;5385.703786291713;5389.487998640123;5010.949890501121;5019.0965626187635;5020.924686129711;5036.269740887551;5037.4458809530925;5265.763040663102;5304.893902121858;5308.920366194588;5309.867253318698;5312.38907525624;4997.650164488597;5172.353455818023;5172.5603323717905;5190.247414124855;5220.086484865057;4993.450720420823;5001.8749531260555;5004.199328107486;5021.84934451967;5063.139266324807;3740.663340299386;3757.8308976095595;3758.755680880734;3767.6420740029653;3768.2086761780333;5091.643584949166;5099.209622508517;5245.134552798745;5280.234366016983;5290.232916227203;5080.390353157497;5200.765965531485;5209.817656382009;5213.895722085613;5214.634975551675;5182.740862956913;5199.844004679866;5201.1678131498775;5201.661891977009;5212.791488340576;4949.713074600558;5104.2993829473335;5115.2071428928575;5119.232115182753;5121.129408000724;5202.375714914235;5229.790808367775;5238;5245.213218017328;5252.7898884045735;5115.514026167508;5118.029558619884;5142.51146141116;5152.690838549699;5155.639105262596 22:17:04 INFO - PROCESS | 24444 | |5;yui.html;626.1734510446211;654.8166513376253;694.1843334082452;706.9328413800694;714.453443116016;11445.656630301084;11503.194776365648;11627.418629068545;11760.705982350446;11782;11455.656330310083;11508.769824603503;11530.192886497949;11530.192886497949;11536.769264614702;638.1098367776948;770.5492287012105;808.4987307869114;814.4380377539479;821.720614990903;797.956112413817;807.3702512040618;809.3686924199134;809.7368355284526;811.6266517402003;838.2372041442288;847.8389106069858;849.0829903703985;849.1508491508491;849.8937632795901;660.9966950165267;679.7484930575719;684.2712511175582;809.3323008517996;833.62903507939;610.7495926670044;616.4421198815035;623.7130919776909;624.0639041437843;624.4941597306151;12195.390230488529;12311.876881231163;12316.876831231752;12322;12352.197107188003;12318.692032699255;12652.304123273216;13040.739185216242;13049;13153.276569788657;9108.726738197865;9131.223845973034;9136.177744003071;9342.90657093434;9352.064793520662;3036.7722420818304;3069.2480342316053;3083.075077476748;3087.8764849405998;3158.2262345725217;47714;48173.518264817256;48180;48312;48442;9704.902950970541;9736.123748862636;9869;9905.752356191153;10103.292769506212;17083.31666733317;17121.315147394213;17127.05801180947;17168.656626867643;17211.225494852762;6126.754929802847;6168.25980882297;6244;6245.875082498415;6246.781362652377;3309.8179600121744;3325.48454989477;3360.7311415086733;3416.9829150854584;3424.280901010816;2752.683441404224;2852.0017993702454;2852.144356693025;2856.7000464951298;2858.4140251248446;462.08507155831643;470.38614607936285;480.7307907571771;493.25025960540495;500.0199608766858;512.6155383462403;550.070381056022;555.5999680230228;573.5153795043182;604.8699529601068;7468.253174682488;7499.700011999459;7579.1662917079075;7819.843603127905;7843.960780196063;457.5630273089192;494.8011108185597;511.00354309097406;524.1351769580147;575.0827430248746;3635.2729454109285;3676.5219822464337;3685.0603096210293;3693.372126738461;3793.6775374093513;55775.44224557783;55803.72098139564;56382.718086410125;56464.717676411354;56540.43459565352;46705.299420508716;47145.29282060772;47306.52693473021;47761.5223847764;48094.27858582124;43741.78129109334;43932.78033609811;44005.77997109994;44542.77728611336;44794.77602611966;7046.4010559101;7172.246914073947;7199.3520583147765;7199.604021778643;7341.559506429631;29129.271768205963;29464.55803162997;29821.70178298276;30261.848690756404;30433.23916902095;38167.2366552673;39384.6061539381;39404.80297598494;39523.20953580855;39976;10073.496325183858;10116.645917392856;10143.188544916242;10326.380417174994;10407.58369665205;11825.349605771766;11941.820872686743;12132.636020919386;12146;12857.164284321489;7525.8118547036765;9381.249500040118;10044.698659040241;10243.282970192015;11606.187566870576;9855.35940163887;10109.19126469866;10190.745231369276;10324.48377581103;10451.111655509367;10508.369497830156;10567.418791966209;10685.57257709683;10945.781084378426;11279.379634120201;9166.11087330918;9358.251339892928;9382.812343753223;9479.099485548863;9797.167240784613;8521.190486903733;8896.733098007071;9016.954915225382;9068.546572671208;9079.636814527345 22:17:04 INFO - PROCESS | 24444 | __end_tp_report 22:17:04 INFO - PROCESS | 24444 | __start_cc_report 22:17:04 INFO - PROCESS | 24444 | _x_x_mozilla_cycle_collect,1034 22:17:04 INFO - PROCESS | 24444 | __end_cc_report 22:17:04 INFO - PROCESS | 24444 | __startTimestamp1461129424012__endTimestamp 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | ------- Summary: start ------- 22:17:04 INFO - PROCESS | 24444 | Number of tests: 6 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | [#0] dojo.html Cycles:165 Average:4555.71 Median:4676.32 stddev:460.76 (9.9%) stddev-sans-first:435.41 22:17:04 INFO - PROCESS | 24444 | Values: 2582.9 2645.4 2653.0 2660.7 2678.4 4483.6 4539.5 4582.3 4586.0 4586.1 4542.6 4599.1 4601.2 4640.7 4676.3 4245.2 4273.7 4278.9 4319.6 4335.9 4231.1 4319.2 4327.5 4360.1 4379.2 4185.6 4240.2 4283.3 4322.0 4331.8 4218.2 4253.6 4291.4 4307.3 4318.5 4233.5 4235.2 4241.0 4264.9 4271.5 4403.0 4510.5 4511.1 4560.4 4560.6 4937.9 4963.4 4967.3 4979.6 5007.4 4961.2 4975.0 4989.1 4991.2 5028.2 4468.6 4617.8 4650.2 4653.7 4711.1 5015.0 5033.9 5035.9 5043.2 5080.6 4848.5 4854.5 4855.0 4861.5 4892.1 4721.7 4936.3 4969.5 5017.7 5020.6 4837.4 4852.8 4864.9 4877.5 4900.5 4844.7 4848.7 4848.8 4850.7 4903.8 3973.9 4069.5 4128.3 4202.9 4216.8 3640.6 3642.1 3661.2 3696.5 3700.8 4239.7 4265.8 4270.7 4274.7 4313.8 4777.2 4833.6 4840.8 4841.0 4887.7 4252.0 4268.0 4286.6 4306.5 4310.4 4470.4 4477.3 4479.4 4483.0 4519.9 4511.4 4597.7 4645.1 4685.4 4740.0 4952.0 4957.7 4959.7 4973.2 5025.7 4647.4 4668.4 4688.6 4692.7 4742.5 4690.1 4781.4 4871.5 4877.5 4908.3 4902.7 4925.7 4928.7 4930.6 4935.9 4774.1 4780.3 4780.5 4801.4 4835.9 4576.5 4731.8 4768.9 4785.4 4827.0 4670.6 4674.0 4679.5 4687.1 4728.9 4791.9 4792.2 4797.1 4798.1 4845.7 4536.8 4703.6 4787.3 4787.6 4790.2 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | [#1] ext.html Cycles:180 Average:44327.99 Median:188462.91 stddev:76985.20 (40.8%) stddev-sans-first:77131.08 22:17:04 INFO - PROCESS | 24444 | Values: 576.8 594.6 610.6 615.4 620.4 26288.9 33226.2 33807.7 33821.0 33876.0 36368.0 36544.6 36843.0 36881.4 37117.0 7434.6 7638.6 7686.3 7689.8 7690.0 7755.1 7831.4 7864.6 7884.2 7892.1 7856.2 7867.9 7930.3 7939.2 7940.4 7782.3 7902.0 7911.0 7917.8 7932.5 7735.6 7805.9 7806.5 7812.6 7832.6 37229.3 37591.2 37659.0 37671.2 37703.0 2909.7 3224.3 3325.9 3341.8 3591.6 28150.9 28467.1 29118.4 30068.4 31953.4 3301.7 3303.5 3345.7 3363.5 3382.2 195940.0 196141.0 197388.0 197649.0 197998.0 51370.0 51981.7 52105.7 52189.7 52199.0 57717.7 59188.0 59365.4 59366.0 59429.4 13601.1 13677.6 13707.4 13715.7 13828.5 10372.5 10456.2 10460.7 10470.9 10473.4 17600.9 17875.6 18008.9 18621.5 18644.9 6667.9 6859.9 6904.6 7000.2 7042.1 881.9 903.8 943.7 1000.5 1011.2 24787.1 25251.6 25256.5 25280.7 25291.5 885.0 986.7 994.2 1006.5 1045.0 13591.7 14070.4 14135.4 14355.9 14372.3 331982.0 341334.0 342242.0 342657.0 343169.0 41339.4 42337.2 42448.8 42496.6 42528.0 1120.0 1161.8 1187.4 1239.3 1252.7 25523.9 27513.9 27851.6 28747.0 28786.1 40203.8 47278.5 49281.8 49305.5 49462.3 317183.0 319865.0 321247.0 321435.0 321958.0 32749.7 33773.7 33833.1 33838.5 33842.8 34471.5 41950.6 46112.3 47037.5 47577.0 34498.8 34555.7 34754.7 35146.6 35155.0 33673.0 33860.8 34095.0 34111.3 34268.8 34278.3 34554.5 34617.5 34639.7 34980.0 29659.9 31551.7 31600.5 31780.7 31858.9 24102.4 24241.6 24371.9 24704.8 24747.6 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | [#2] jquery.html Cycles:180 Average:25355.51 Median:427524.00 stddev:70156.91 (16.4%) stddev-sans-first:70328.64 22:17:04 INFO - PROCESS | 24444 | Values: 376.8 378.7 388.2 393.6 394.5 15688.8 16403.5 16512.0 16523.7 16546.6 14905.7 15975.8 16597.9 16651.5 16666.1 4956.1 5081.8 5110.4 5118.8 5128.0 3670.6 5482.5 5837.9 5854.6 5873.7 5550.4 5776.7 5800.9 5821.6 5834.9 5701.7 5713.4 5713.8 5728.7 5736.1 3339.8 3540.3 3543.3 3546.8 4762.7 20238.9 20385.9 20492.2 20736.9 20794.8 1850.6 1875.9 1924.8 1968.8 2180.9 12329.5 12360.6 13014.3 13166.4 13584.5 1779.6 1804.0 1860.5 1862.7 1884.2 65873.3 70079.6 70415.0 70527.0 70911.0 9500.8 9752.2 9771.2 10031.2 10136.6 13545.4 13641.1 13654.2 13663.1 13726.9 7250.3 7344.5 7384.6 7492.8 7499.3 6978.3 6996.8 7014.5 7079.2 7128.1 6065.8 6207.3 6224.6 6225.5 6241.8 1618.7 1721.5 1764.5 1767.5 1815.5 809.8 898.8 934.6 960.4 1025.9 15796.7 16598.0 17204.3 17237.7 17666.8 850.3 854.8 884.5 898.3 934.6 9213.3 9622.7 9984.4 9985.0 9994.1 423124.0 424378.0 425666.0 425847.0 429201.0 75556.0 80580.0 83812.6 83918.6 84795.6 969.7 969.7 973.8 1006.4 1020.4 15171.5 15427.2 15662.6 15731.8 15976.8 34747.0 35050.3 35995.6 36325.1 36657.0 47514.3 48443.5 49879.8 50248.7 51097.0 7719.5 7756.6 7803.5 7804.1 7945.0 6665.6 8614.1 10158.8 10403.9 11309.7 6038.4 8566.7 10102.8 10105.5 10351.7 9799.4 9897.2 10145.8 10217.3 10443.6 10344.2 10562.7 10568.8 10663.3 10915.9 6380.8 6650.7 6797.5 7590.8 7657.9 9112.0 9597.4 10362.5 10483.2 10577.3 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | [#3] mootools.html Cycles:180 Average:5294.72 Median:5091.44 stddev:2961.05 (58.2%) stddev-sans-first:2954.03 22:17:04 INFO - PROCESS | 24444 | Values: 1285.5 1459.4 1479.8 1638.7 1798.5 7009.7 7743.6 7958.1 7970.0 7983.0 7703.2 7836.6 7868.4 7873.8 7884.7 1907.8 1983.3 1985.0 2244.6 2272.6 2006.3 2234.3 2314.4 2315.3 2319.9 2150.7 2175.9 2176.6 2178.9 2187.7 1832.0 2126.6 2128.1 2128.8 2131.6 2194.4 2292.6 2297.0 2298.0 2306.5 7770.0 7831.5 7864.1 7864.8 7868.6 4560.1 4710.4 4710.7 4717.0 4722.8 2875.3 2945.1 3022.3 3034.2 3044.2 903.8 934.6 942.1 942.9 948.2 10735.1 10940.1 10958.6 10990.3 10994.8 4060.4 4249.0 4251.9 4266.6 4289.3 9398.4 9424.0 9431.7 9438.8 9455.0 4745.4 4759.9 4762.4 4763.5 4764.3 4206.0 4254.7 4301.4 4319.2 4362.3 3661.1 3670.6 3759.3 3785.7 3805.6 1228.1 1241.3 1241.7 1241.8 1261.7 829.9 870.9 875.2 895.7 917.5 5519.7 5589.5 5675.6 5687.5 5870.4 829.7 843.5 859.9 866.9 941.2 3686.7 3847.7 3848.7 3853.1 3899.7 9759.7 10078.0 10158.2 10175.3 10284.4 9988.8 10008.4 10158.9 10176.8 10197.6 7303.0 7473.5 7497.4 7550.4 7631.0 5213.5 5229.8 5271.3 5373.9 5411.4 9183.6 9234.6 9237.5 9263.8 9313.6 8109.4 8446.4 8600.6 8976.3 9051.2 7416.6 7506.8 7526.6 7556.5 7578.9 7246.9 7399.9 7581.5 7599.9 7605.1 7058.6 7064.0 7154.2 7168.2 7254.5 6866.3 6872.9 6918.6 6955.3 7046.9 6145.9 6357.7 6541.1 6657.5 6680.8 4790.4 4912.4 4916.4 4927.2 4941.5 5012.2 5024.7 5085.8 5097.1 5099.3 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | [#4] prototype.html Cycles:180 Average:4308.09 Median:4954.46 stddev:1240.56 (25.0%) stddev-sans-first:1207.28 22:17:04 INFO - PROCESS | 24444 | Values: 314.3 319.4 321.8 327.5 328.6 4792.8 4959.3 4971.7 4979.8 4994.7 4710.8 4909.9 4919.8 4941.7 4959.2 3925.4 3941.9 3950.1 3952.9 3955.6 3684.8 3788.9 3927.3 3945.3 3948.1 3917.7 3920.3 3921.5 3923.2 3936.2 3892.5 3896.8 3903.7 3905.9 3938.6 3463.8 3483.4 3483.4 3484.4 3498.8 4573.3 4791.4 4807.8 4814.7 4829.9 4334.6 4354.9 4372.3 4376.1 4380.0 5185.0 5205.3 5214.4 5216.2 5222.2 3555.8 3685.5 3685.7 3696.2 3702.5 5392.6 5403.3 5420.5 5444.8 5452.6 3784.1 3793.4 3799.4 3806.7 3807.0 3616.7 3818.5 3843.9 3852.5 3854.2 4364.0 4388.4 4394.4 4394.5 4398.3 5199.4 5199.5 5212.7 5216.5 5216.6 1245.9 1293.3 1325.5 1338.4 1341.3 896.8 902.0 915.1 917.8 920.9 4571.3 4589.2 4589.7 4598.4 4599.2 5342.4 5344.7 5345.2 5346.6 5351.7 4455.7 4573.2 4575.3 4584.3 4584.9 2818.3 2824.6 2834.4 2834.7 2838.7 5004.3 5039.1 5046.9 5048.4 5054.0 5182.4 5360.8 5383.3 5385.7 5389.5 5010.9 5019.1 5020.9 5036.3 5037.4 5265.8 5304.9 5308.9 5309.9 5312.4 4997.7 5172.4 5172.6 5190.2 5220.1 4993.5 5001.9 5004.2 5021.8 5063.1 3740.7 3757.8 3758.8 3767.6 3768.2 5091.6 5099.2 5245.1 5280.2 5290.2 5080.4 5200.8 5209.8 5213.9 5214.6 5182.7 5199.8 5201.2 5201.7 5212.8 4949.7 5104.3 5115.2 5119.2 5121.1 5202.4 5229.8 5238.0 5245.2 5252.8 5115.5 5118.0 5142.5 5152.7 5155.6 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - PROCESS | 24444 | [#5] yui.html Cycles:180 Average:12808.44 Median:24121.13 stddev:15135.53 (62.7%) stddev-sans-first:15150.35 22:17:04 INFO - PROCESS | 24444 | Values: 626.2 654.8 694.2 706.9 714.5 11445.7 11503.2 11627.4 11760.7 11782.0 11455.7 11508.8 11530.2 11530.2 11536.8 638.1 770.5 808.5 814.4 821.7 798.0 807.4 809.4 809.7 811.6 838.2 847.8 849.1 849.2 849.9 661.0 679.7 684.3 809.3 833.6 610.7 616.4 623.7 624.1 624.5 12195.4 12311.9 12316.9 12322.0 12352.2 12318.7 12652.3 13040.7 13049.0 13153.3 9108.7 9131.2 9136.2 9342.9 9352.1 3036.8 3069.2 3083.1 3087.9 3158.2 47714.0 48173.5 48180.0 48312.0 48442.0 9704.9 9736.1 9869.0 9905.8 10103.3 17083.3 17121.3 17127.1 17168.7 17211.2 6126.8 6168.3 6244.0 6245.9 6246.8 3309.8 3325.5 3360.7 3417.0 3424.3 2752.7 2852.0 2852.1 2856.7 2858.4 462.1 470.4 480.7 493.3 500.0 512.6 550.1 555.6 573.5 604.9 7468.3 7499.7 7579.2 7819.8 7844.0 457.6 494.8 511.0 524.1 575.1 3635.3 3676.5 3685.1 3693.4 3793.7 55775.4 55803.7 56382.7 56464.7 56540.4 46705.3 47145.3 47306.5 47761.5 48094.3 43741.8 43932.8 44005.8 44542.8 44794.8 7046.4 7172.2 7199.4 7199.6 7341.6 29129.3 29464.6 29821.7 30261.8 30433.2 38167.2 39384.6 39404.8 39523.2 39976.0 10073.5 10116.6 10143.2 10326.4 10407.6 11825.3 11941.8 12132.6 12146.0 12857.2 7525.8 9381.2 10044.7 10243.3 11606.2 9855.4 10109.2 10190.7 10324.5 10451.1 10508.4 10567.4 10685.6 10945.8 11279.4 9166.1 9358.3 9382.8 9479.1 9797.2 8521.2 8896.7 9017.0 9068.5 9079.6 22:17:04 INFO - PROCESS | 24444 | -------- Summary: end -------- 22:17:04 INFO - PROCESS | 24444 | 22:17:04 INFO - TEST-INFO | 24444: exit 0 22:17:04 INFO - TEST-OK | dromaeo_css | took 1118527ms 22:17:04 INFO - TEST-START | kraken 22:17:04 INFO - operating with platform_type : linux_ 22:17:04 INFO - Initialising browser for kraken test... 22:17:04 INFO - TEST-INFO | started process 24624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjw4y0/profile http://localhost:54005/getInfo.html) 22:17:09 INFO - PROCESS | 24624 | __metrics Screen width/height:1600/1200 22:17:09 INFO - PROCESS | 24624 | colorDepth:24 22:17:09 INFO - PROCESS | 24624 | Browser inner width/height: 1024/697 22:17:09 INFO - PROCESS | 24624 | __metrics 22:17:10 ERROR - PROCESS | 24624 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:17:11 INFO - TEST-INFO | 24624: exit 0 22:17:11 INFO - Browser initialized. 22:17:11 INFO - Running cycle 1/1 for kraken test... 22:17:11 INFO - TEST-INFO | started process 24706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjw4y0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:17:23 INFO - PROCESS | 24706 | RSS: Main: 155267072 22:17:23 INFO - PROCESS | 24706 | 22:17:25 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54005/tests/kraken/driver.html?testName=audio-beat-detection) 22:17:26 INFO - PROCESS | 24706 | RSS: Main: 210264064 22:17:26 INFO - PROCESS | 24706 | 22:17:29 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54005/tests/kraken/driver.html?testName=audio-dft) 22:17:30 INFO - PROCESS | 24706 | RSS: Main: 195661824 22:17:30 INFO - PROCESS | 24706 | 22:17:33 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54005/tests/kraken/driver.html?testName=audio-fft) 22:17:34 INFO - PROCESS | 24706 | RSS: Main: 266805248 22:17:34 INFO - PROCESS | 24706 | 22:17:36 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54005/tests/kraken/driver.html?testName=audio-oscillator) 22:17:36 INFO - PROCESS | 24706 | RSS: Main: 174481408 22:17:36 INFO - PROCESS | 24706 | 22:17:39 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:17:39 INFO - PROCESS | 24706 | RSS: Main: 178847744 22:17:39 INFO - PROCESS | 24706 | 22:17:42 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54005/tests/kraken/driver.html?testName=imaging-darkroom) 22:17:43 INFO - PROCESS | 24706 | RSS: Main: 215384064 22:17:43 INFO - PROCESS | 24706 | 22:17:46 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54005/tests/kraken/driver.html?testName=imaging-desaturate) 22:17:47 INFO - PROCESS | 24706 | RSS: Main: 212869120 22:17:47 INFO - PROCESS | 24706 | 22:17:50 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54005/tests/kraken/driver.html?testName=json-parse-financial) 22:17:50 INFO - PROCESS | 24706 | RSS: Main: 214474752 22:17:50 INFO - PROCESS | 24706 | 22:17:52 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:17:53 INFO - PROCESS | 24706 | RSS: Main: 201756672 22:17:53 INFO - PROCESS | 24706 | 22:17:55 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:17:55 INFO - PROCESS | 24706 | RSS: Main: 206204928 22:17:55 INFO - PROCESS | 24706 | 22:17:57 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:17:58 INFO - PROCESS | 24706 | RSS: Main: 219303936 22:17:58 INFO - PROCESS | 24706 | 22:18:01 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:18:01 INFO - PROCESS | 24706 | RSS: Main: 222109696 22:18:01 INFO - PROCESS | 24706 | 22:18:04 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:18:05 INFO - PROCESS | 24706 | RSS: Main: 214999040 22:18:05 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | Cycle 1(1): loaded http://localhost:54005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54005/tests/kraken/driver.html?testName=ai-astar) 22:18:07 INFO - PROCESS | 24706 | RSS: Main: 278630400 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | __start_tp_report 22:18:07 INFO - PROCESS | 24706 | _x_x_mozilla_page_load 22:18:07 INFO - PROCESS | 24706 | _x_x_mozilla_page_load_details 22:18:07 INFO - PROCESS | 24706 | |i|pagename|runs| 22:18:07 INFO - PROCESS | 24706 | |0;ai-astar;111;113;108;112;113;112;102;112;112;113 22:18:07 INFO - PROCESS | 24706 | |1;audio-beat-detection;169;132;161;193;134;159;157;133;188;136 22:18:07 INFO - PROCESS | 24706 | |2;audio-dft;160;160;161;161;161;161;160;161;161;161 22:18:07 INFO - PROCESS | 24706 | |3;audio-fft;74;77;125;112;75;75;74;113;99;75 22:18:07 INFO - PROCESS | 24706 | |4;audio-oscillator;94;95;139;94;93;93;139;95;93;144 22:18:07 INFO - PROCESS | 24706 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;119;117 22:18:07 INFO - PROCESS | 24706 | |6;imaging-darkroom;147;147;146;146;146;148;147;147;147;147 22:18:07 INFO - PROCESS | 24706 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 22:18:07 INFO - PROCESS | 24706 | |8;json-parse-financial;66;65;65;65;65;65;65;80;65;62 22:18:07 INFO - PROCESS | 24706 | |9;json-stringify-tinderbox;65;65;65;64;65;64;65;65;65;64 22:18:07 INFO - PROCESS | 24706 | |10;stanford-crypto-aes;79;80;78;78;79;79;81;81;82;81 22:18:07 INFO - PROCESS | 24706 | |11;stanford-crypto-ccm;134;133;133;134;130;132;130;135;166;132 22:18:07 INFO - PROCESS | 24706 | |12;stanford-crypto-pbkdf2;171;182;175;178;176;174;172;171;171;172 22:18:07 INFO - PROCESS | 24706 | |13;stanford-crypto-sha256-iterative;72;71;71;72;74;72;71;71;71;71 22:18:07 INFO - PROCESS | 24706 | __end_tp_report 22:18:07 INFO - PROCESS | 24706 | __start_cc_report 22:18:07 INFO - PROCESS | 24706 | _x_x_mozilla_cycle_collect,1896 22:18:07 INFO - PROCESS | 24706 | __end_cc_report 22:18:07 INFO - PROCESS | 24706 | __startTimestamp1461129487498__endTimestamp 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | ------- Summary: start ------- 22:18:07 INFO - PROCESS | 24706 | Number of tests: 14 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:3.63 22:18:07 INFO - PROCESS | 24706 | Values: 111.0 113.0 108.0 112.0 113.0 112.0 102.0 112.0 112.0 113.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:160.00 stddev:22.57 (14.1%) stddev-sans-first:23.46 22:18:07 INFO - PROCESS | 24706 | Values: 169.0 132.0 161.0 193.0 134.0 159.0 157.0 133.0 188.0 136.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 22:18:07 INFO - PROCESS | 24706 | Values: 160.0 160.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 161.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#3] audio-fft Cycles:10 Average:89.90 Median:75.00 stddev:20.21 (26.9%) stddev-sans-first:20.60 22:18:07 INFO - PROCESS | 24706 | Values: 74.0 77.0 125.0 112.0 75.0 75.0 74.0 113.0 99.0 75.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.50 stddev:22.66 (24.2%) stddev-sans-first:23.47 22:18:07 INFO - PROCESS | 24706 | Values: 94.0 95.0 139.0 94.0 93.0 93.0 139.0 95.0 93.0 144.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 22:18:07 INFO - PROCESS | 24706 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 22:18:07 INFO - PROCESS | 24706 | Values: 147.0 147.0 146.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:18:07 INFO - PROCESS | 24706 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.00 stddev:4.92 (7.6%) stddev-sans-first:5.22 22:18:07 INFO - PROCESS | 24706 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 65.0 80.0 65.0 62.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 22:18:07 INFO - PROCESS | 24706 | Values: 65.0 65.0 65.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.50 stddev:1.40 (1.7%) stddev-sans-first:1.45 22:18:07 INFO - PROCESS | 24706 | Values: 79.0 80.0 78.0 78.0 79.0 79.0 81.0 81.0 82.0 81.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:133.50 stddev:10.70 (8.0%) stddev-sans-first:11.33 22:18:07 INFO - PROCESS | 24706 | Values: 134.0 133.0 133.0 134.0 130.0 132.0 130.0 135.0 166.0 132.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.50 stddev:3.65 (2.1%) stddev-sans-first:3.68 22:18:07 INFO - PROCESS | 24706 | Values: 171.0 182.0 175.0 178.0 176.0 174.0 172.0 171.0 171.0 172.0 22:18:07 INFO - PROCESS | 24706 | 22:18:07 INFO - PROCESS | 24706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.50 stddev:0.97 (1.4%) stddev-sans-first:1.01 22:18:07 INFO - PROCESS | 24706 | Values: 72.0 71.0 71.0 72.0 74.0 72.0 71.0 71.0 71.0 71.0 22:18:07 INFO - PROCESS | 24706 | -------- Summary: end -------- 22:18:07 INFO - PROCESS | 24706 | 22:18:08 INFO - TEST-INFO | 24706: exit 0 22:18:08 INFO - TEST-OK | kraken | took 63694ms 22:18:08 INFO - SUITE-END | took 1182s 22:18:08 INFO - Completed test suite (00:19:42) 22:18:08 INFO - javascript benchmark 22:18:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.9354266143346, 2645.4180080382307, 2653.0449038346205, 2660.694020187679, 2678.370582913015, 4483.574060464259, 4539.546045395463, 4582.335561343603, 4585.954140458594, 4586.059857729166, 4542.613877820381, 4599.080183963204, 4601.217792975194, 4640.67515273931, 4676.321933319667, 4245.150969806035, 4273.7008409411355, 4278.871633850989, 4319.589638984307, 4335.869923902288, 4231.1114665920195, 4319.179355922381, 4327.5239723630375, 4360.10617823347, 4379.189849877783, 4185.560516145822, 4240.173166232586, 4283.293256612656, 4322.027543802619, 4331.7617531035785, 4218.177455396169, 4253.553376895412, 4291.377750226231, 4307.267764480046, 4318.52496225415, 4233.491980962304, 4235.174141042498, 4241.045764702917, 4264.850730224458, 4271.466066741657, 4402.977985110086, 4510.548945105496, 4511.142882852248, 4560.384348113029, 4560.635149188057, 4937.851864444036, 4963.354763880709, 4967.254911763228, 4979.57673597741, 5007.37407824022, 4961.156603377399, 4975.004999000214, 4989.101961646902, 4991.176455884774, 5028.195488721787, 4468.553144685506, 4617.815287388534, 4650.162970665279, 4653.697509661895, 4711.081339138835, 5014.974925125351, 5033.899322013539, 5035.874103147451, 5043.167877300278, 5080.59355251579, 4848.539388758062, 4854.538818812207, 4855.028994201174, 4861.538153875376, 4892.143874821963, 4721.693089949143, 4936.333594964633, 4969.453360130383, 5017.67385119966, 5020.623453241022, 4837.395325584302, 4852.781624826891, 4864.854054378375, 4877.463479017305, 4900.460949295574, 4844.685095468783, 4848.733319667382, 4848.8302909398, 4850.733209673502, 4903.828366007173, 3973.940390894139, 4069.4709687740406, 4128.298189307825, 4202.915941681149, 4216.831326746896, 3640.6177351377723, 3642.0530662028063, 3661.1579336752698, 3696.4640127181947, 3700.777953322809, 4239.660827133822, 4265.808038638269, 4270.701050926467, 4274.658027357804, 4313.762743049099, 4777.163996300634, 4833.564979151894, 4840.757962101951, 4840.975795121002, 4887.682300650517, 4252.043290259667, 4267.957320426756, 4286.635635970977, 4306.5262821089655, 4310.353446982915, 4470.396496472999, 4477.328400739915, 4479.350494178391, 4483.036147228361, 4519.932201016987, 4511.39096222019, 4597.678162528591, 4645.094206629675, 4685.437747470325, 4740.004599034172, 4951.950480495149, 4957.677750946177, 4959.652824302264, 4973.154563724248, 5025.748712564284, 4647.395838540968, 4668.369506226378, 4688.578027977498, 4692.671512994058, 4742.478327384054, 4690.085433340466, 4781.4262288524205, 4871.488493708252, 4877.487863774394, 4908.263760435963, 4902.681325713817, 4925.679830810986, 4928.728919909439, 4930.630202734881, 4935.851924442272, 4774.092922344744, 4780.330753694555, 4780.4741478436645, 4801.351817504732, 4835.879103022453, 4576.496585375673, 4731.84069902876, 4768.904621907612, 4785.401824771903, 4827.034593081327, 4670.602998745145, 4674.041821426667, 4679.461861885927, 4687.1328804171335, 4728.881777955578, 4791.880202994953, 4792.2332426811545, 4797.136515427256, 4798.064377446504, 4845.709257444564, 4536.795844186953, 4703.647226457961, 4787.257975013878, 4787.640926930564, 4790.161721698759], "value": 4527.652814534852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8384852241371, 594.6372712645286, 610.5878531990908, 615.4430240632228, 620.435403782558, 26288.86855565722, 33226.16934576637, 33807.66192338076, 33821.0, 33875.983720488395, 36368.0, 36544.634553654454, 36843.0, 36881.44677829828, 37117.0, 7434.628268586576, 7638.5798781067015, 7686.346660533862, 7689.769306920802, 7690.038745156856, 7755.069391672979, 7831.373490120776, 7864.606769661523, 7884.172161923001, 7892.092409372909, 7856.2143785621265, 7867.921320786805, 7930.286274235317, 7939.245771651713, 7940.40446966477, 7782.299593036626, 7902.0, 7911.0, 7917.841643167105, 7932.484388514728, 7735.574543400111, 7805.921940780577, 7806.453548251625, 7812.648430820626, 7832.647530861068, 37229.25541489155, 37591.24817503662, 37659.0, 37671.24657506862, 37703.0, 2909.7090290970946, 3224.3067740435918, 3325.866965321384, 3341.8329083545727, 3591.6049234584175, 28150.85924570364, 28467.145985620464, 29118.41763164746, 30068.398632027238, 31953.36093278145, 3301.669833016679, 3303.4549299365576, 3345.7323414127054, 3363.545921300642, 3382.1882748140515, 195940.020299899, 196141.0, 197388.0, 197649.0, 197998.01000995046, 51370.0, 51981.74009130006, 52105.739471302404, 52189.7390513045, 52199.0, 57717.71141144267, 59188.0, 59365.40634593599, 59366.0, 59429.40570594239, 13601.115927464882, 13677.589672309847, 13707.383167757474, 13715.657108572366, 13828.516001939885, 10372.533236004398, 10456.163506919429, 10460.738481538023, 10470.947645261725, 10473.371597704163, 17600.91199543994, 17875.642487150184, 18008.909955450137, 18621.534461638566, 18644.906775466035, 6667.86664266712, 6859.9314006860295, 6904.585724856424, 7000.194977577542, 7042.119735033121, 881.9426737262057, 903.823754367905, 943.7263193673758, 1000.494750151169, 1011.185995273797, 24787.13245036415, 25251.62122568163, 25256.494870102862, 25280.747192528208, 25291.49417011686, 885.0, 986.7172675521794, 994.16986816008, 1006.5017816181037, 1045.038564520643, 13591.728165436636, 14070.437182512585, 14135.363908624136, 14355.85644143566, 14372.28138593087, 331982.0, 341334.0, 342242.0, 342657.0, 343169.0, 41339.37990930139, 42337.15325693469, 42448.78775606164, 42496.57503424926, 42528.0, 1119.9664010079712, 1161.814109742437, 1187.3647598534742, 1239.2750241109052, 1252.6930901928904, 25523.87238063798, 27513.862430688518, 27851.582226267026, 28747.0, 28786.136415907557, 40203.798981006075, 47278.527214727415, 49281.75359123181, 49305.50694493153, 49462.258066128314, 317183.0, 319865.0, 321247.0, 321435.0, 321958.0, 32749.67250327466, 33773.66226337705, 33833.10919244318, 33838.49242261319, 33842.830785845916, 34471.482927755605, 41950.580494195885, 46112.30831537463, 47037.529624704686, 47577.0, 34498.82750586231, 34555.65444345625, 34754.652453475144, 35146.64853351434, 35155.0, 33673.0, 33860.83069584735, 34094.95430274191, 34111.31777364389, 34268.82865585756, 34278.314433710686, 34554.481682774276, 34617.480737789454, 34639.65360346465, 34979.95060148199, 29659.851700741357, 31551.684483155794, 31600.525992109677, 31780.682193177774, 31858.88493902795, 24102.39744006414, 24241.63637545403, 24371.878140609184, 24704.752952470244, 24747.62878556787], "value": 17194.793571691804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.771724179176, 378.71049077889796, 388.180938220355, 393.6240889950098, 394.48125714685204, 15688.843111568882, 16403.507894763145, 16512.0, 16523.66952660949, 16546.586335341606, 14905.701885962275, 15975.760363594556, 16597.91701041496, 16651.50045498634, 16666.083365414896, 4956.083124621957, 5081.79672813087, 5110.386753589574, 5118.8464346069495, 5128.025675121734, 3670.5778835433866, 5482.533984611293, 5837.9124313135335, 5854.590178687472, 5873.676947767871, 5550.417206193352, 5776.682282474483, 5800.9129863052085, 5821.592488525805, 5834.912476312858, 5701.743421546041, 5713.400092990239, 5713.771449142029, 5728.68492232927, 5736.139579063132, 3339.8497067632015, 3540.291941611688, 3543.3090547343277, 3546.7871927684423, 4762.714237145782, 20238.898805506025, 20385.898070509702, 20492.18031278747, 20736.896315518326, 20794.792052079436, 1850.5743678953916, 1875.9062046897736, 1924.7786504551875, 1968.793276705954, 2180.858244214121, 12329.5068197272, 12360.567380141652, 13014.349282535835, 13166.407511661999, 13584.524541641094, 1779.635174789178, 1803.9549011274692, 1860.5255659806662, 1862.7205919112241, 1884.1897983866932, 65873.34126658768, 70079.64960175166, 70415.0, 70527.0, 70911.0, 9500.762480938032, 9752.21982241419, 9771.169450596637, 10031.197504199647, 10136.645217417356, 13545.39045742944, 13641.113327633871, 13654.249016304198, 13663.111897726616, 13726.86273137256, 7250.347468727839, 7344.522606030591, 7384.556926584422, 7492.812679682943, 7499.287567681062, 6978.267281935425, 6996.755113571001, 7014.5440546364325, 7079.185893622196, 7128.073350464407, 6065.848353791191, 6207.34822843604, 6224.595401298901, 6225.533085018642, 6241.812745617639, 1618.708632446171, 1721.4577408116404, 1764.4886675515888, 1767.454864994404, 1815.5370380552874, 809.8258874342044, 898.7842917699705, 934.5934518484481, 960.3805545423163, 1025.876894772632, 15796.684066318609, 16598.0, 17204.31182752701, 17237.655246894992, 17666.823331766776, 850.2730165708354, 854.769212312672, 884.5046773806689, 898.3217670658611, 934.5747684803398, 9213.30900182489, 9622.711318660451, 9984.35101718386, 9984.950075249577, 9994.10053095225, 423124.0, 424378.0, 425666.0, 425847.0, 429201.0, 75556.0, 80580.0, 83812.58093709493, 83918.58040709757, 84795.57602212073, 969.7090872738291, 969.7187815533557, 973.8003709239589, 1006.441425009127, 1020.3673722292226, 15171.468998584996, 15427.151506667242, 15662.608434789221, 15731.764023539426, 15976.840231597535, 34747.0, 35050.298994020486, 35995.640043599225, 36325.09187270339, 36657.0, 47514.28728569005, 48443.51556484531, 49879.750601246764, 50248.74875625598, 51097.0, 7719.498232614862, 7756.565035468457, 7803.453758236869, 7804.141544429995, 7944.960275198587, 6665.600063996176, 8614.13883542596, 10158.796824063329, 10403.94798026005, 11309.660710178709, 6038.365971572922, 8566.657333706582, 10102.848457273, 10105.494725263854, 10351.741206469898, 9799.412035277906, 9897.208223342259, 10145.797084058426, 10217.33587316822, 10443.582256709646, 10344.224183186141, 10562.735931601772, 10568.84146737815, 10663.306885052447, 10915.945420272848, 6380.808575742735, 6650.700718467584, 6797.524173307821, 7590.7722768317035, 7657.923420765721, 9112.0, 9597.376170548892, 10362.481875906326, 10483.213758967955, 10577.31247468912], "value": 8275.756907688326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.5372066056225, 1459.3651761483752, 1479.8446163152869, 1638.680457310824, 1798.496421002119, 7009.719611215552, 7743.6128193590375, 7958.124606293318, 7969.999999999993, 7982.960085199566, 7703.191164927686, 7836.568988705619, 7868.4098692598145, 7873.842523149534, 7884.724034658788, 1907.7901430842596, 1983.2860170338668, 1984.9702254466195, 2244.551089782042, 2272.6477396003647, 2006.3278801601407, 2234.329701089675, 2314.375118717945, 2315.30540837748, 2319.895604697784, 2150.731158605174, 2175.8912054397215, 2176.6408542590534, 2178.8583742056794, 2187.6937228787983, 1831.9816801832078, 2126.6384714598557, 2128.0742876848544, 2128.819050380712, 2131.6269652810697, 2194.36363454598, 2292.610256256424, 2297.0467256088705, 2298.0118549023914, 2306.4925716342377, 7770.0287464067, 7831.451798374116, 7864.095629002623, 7864.842703145905, 7868.567228802413, 4560.065186636732, 4710.411198600175, 4710.693804902705, 4716.976415117937, 4722.834700785456, 2875.324298789783, 2945.072302224792, 3022.259546411143, 3034.1959380764115, 3044.2389402649337, 903.7559858838142, 934.6121359635811, 942.0955882352949, 942.8632848237036, 948.170350942925, 10735.141188704885, 10940.070094042016, 10958.616448424347, 10990.340579565252, 10994.780104397947, 4060.39094135882, 4249.043965107826, 4251.851185208503, 4266.637335826427, 4289.335153051282, 9398.389104708172, 9423.952880235693, 9431.717048488556, 9438.764030899145, 9455.0, 4745.406824146981, 4759.881002974953, 4762.380890484214, 4763.523647635208, 4764.2615394613895, 4205.9789701051295, 4254.680898932593, 4301.376300436419, 4319.2009478246, 4362.345648152803, 3661.1213308806227, 3670.5595328560744, 3759.3233218020473, 3785.734998550075, 3805.60041195676, 1228.0728050322127, 1241.273854794937, 1241.6709571963436, 1241.8447694038246, 1261.7098067444356, 829.9004119505698, 870.9418057060701, 875.2123089219754, 895.7312806158257, 917.5366439947784, 5519.668819870821, 5589.469000444951, 5675.574331925122, 5687.544996400278, 5870.383609721003, 829.672279449614, 843.4985725408782, 859.8925134358205, 866.8959724833061, 941.2281928818303, 3686.6866316362875, 3847.7306588539095, 3848.730588858753, 3853.0560012797046, 3899.727019108692, 9759.65841195569, 10078.0, 10158.238132139972, 10175.28772985884, 10284.434356110485, 9988.800223995479, 10008.39949603026, 10158.949205253926, 10176.847347289797, 10197.592096316213, 7303.0, 7473.476856620093, 7497.437692173109, 7550.433717471212, 7631.0, 5213.452587478412, 5229.816956406507, 5271.341082364705, 5373.919391209057, 5411.431799660979, 9183.586738596912, 9234.584443700183, 9237.491937943478, 9263.814723705353, 9313.580888859882, 8109.39179561547, 8446.408751387344, 8600.569971501525, 8976.28189744832, 9051.230645395215, 7416.6291685414435, 7506.812329691801, 7526.623668816646, 7556.4710470266555, 7578.924210757822, 7246.89129663045, 7399.889001664872, 7581.469297149147, 7599.886001709868, 7605.087389513294, 7058.576485410892, 7064.0, 7154.213036566078, 7168.211496735251, 7254.492185546961, 6866.34769696878, 6872.931270687229, 6918.619475928872, 6955.339242771928, 7046.859062818818, 6145.907811382744, 6357.745690172342, 6541.149650545399, 6657.500687448364, 6680.766173183915, 4790.353302304145, 4912.381784948019, 4916.410030796327, 4927.187014142626, 4941.481144479922, 5012.223105418666, 5024.698518088926, 5085.821996230115, 5097.057044446789, 5099.26060721186], "value": 4258.041849079249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.33518109199053, 319.436195115621, 321.7811887916217, 327.5463483075939, 328.5777775558408, 4792.760361981905, 4959.305697202394, 4971.651984361096, 4979.7510124493765, 4994.7003179809235, 4710.835120770774, 4909.9263511047275, 4919.778609962551, 4941.654084214107, 4959.206526955688, 3925.430812532188, 3941.8620348287814, 3950.091478959841, 3952.9407058893994, 3955.624215699504, 3684.778913265213, 3788.924221515568, 3927.253821773854, 3945.3095708251085, 3948.13141108957, 3917.6865850732015, 3920.3335432976464, 3921.450996860442, 3923.1761330120567, 3936.1734035852505, 3892.47451594034, 3896.7856767877756, 3903.6877049835944, 3905.863294784669, 3938.6258305460933, 3463.757536972413, 3483.3555792178277, 3483.372992861284, 3484.372812893678, 3498.7725797823314, 4573.285018118206, 4791.448983366922, 4807.807687692488, 4814.66297359185, 4829.9275510867365, 4334.566543345672, 4354.891127721832, 4372.27857403528, 4376.146651402978, 4379.956200437987, 5184.9740751296, 5205.297284866532, 5214.374275086976, 5216.165413533817, 5222.2427747976335, 3555.768875023115, 3685.5024571682748, 3685.7051435885332, 3696.2053158570766, 3702.500162478058, 5392.56859451243, 5403.2705584745945, 5420.4850539198715, 5444.7822087116465, 5452.6183167178315, 3784.110733977513, 3793.3551296279697, 3799.430085487144, 3806.6764325032127, 3806.980965095212, 3616.65641764032, 3818.541774986964, 3843.9039024024623, 3852.5376954765047, 3854.2291541691775, 4363.978180109143, 4388.385626012361, 4394.36281739146, 4394.472663280427, 4398.252297109499, 5199.428062913076, 5199.480051994846, 5212.713300768418, 5216.452272511332, 5216.608754343363, 1245.906557008228, 1293.2693028438903, 1325.4631874091008, 1338.4244774746758, 1341.2690083904101, 896.7758060484879, 901.9774505637412, 915.1169121797498, 917.8439665256923, 920.9033051529627, 4571.337156112411, 4589.242774942097, 4589.701669391479, 4598.448186217675, 4599.1721490132095, 5342.412334643186, 5344.679319240858, 5345.171498417673, 5346.572274218053, 5351.732413379315, 4455.710378825366, 4573.199690054227, 4575.336576196433, 4584.289435137559, 4584.862454126382, 2818.2672505148807, 2824.5904343870434, 2834.3906060197155, 2834.67401248859, 2838.701936296659, 5004.3494345734825, 5039.118154322979, 5046.873828154252, 5048.419431765321, 5054.0, 5182.382896637249, 5360.812371566976, 5383.327084114486, 5385.703786291713, 5389.487998640123, 5010.949890501121, 5019.0965626187635, 5020.924686129711, 5036.269740887551, 5037.4458809530925, 5265.763040663102, 5304.893902121858, 5308.920366194588, 5309.867253318698, 5312.38907525624, 4997.650164488597, 5172.353455818023, 5172.5603323717905, 5190.247414124855, 5220.086484865057, 4993.450720420823, 5001.8749531260555, 5004.199328107486, 5021.84934451967, 5063.139266324807, 3740.663340299386, 3757.8308976095595, 3758.755680880734, 3767.6420740029653, 3768.2086761780333, 5091.643584949166, 5099.209622508517, 5245.134552798745, 5280.234366016983, 5290.232916227203, 5080.390353157497, 5200.765965531485, 5209.817656382009, 5213.895722085613, 5214.634975551675, 5182.740862956913, 5199.844004679866, 5201.1678131498775, 5201.661891977009, 5212.791488340576, 4949.713074600558, 5104.2993829473335, 5115.2071428928575, 5119.232115182753, 5121.129408000724, 5202.375714914235, 5229.790808367775, 5238.0, 5245.213218017328, 5252.7898884045735, 5115.514026167508, 5118.029558619884, 5142.51146141116, 5152.690838549699, 5155.639105262596], "value": 3919.0582600747402, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.1734510446211, 654.8166513376253, 694.1843334082452, 706.9328413800694, 714.453443116016, 11445.656630301084, 11503.194776365648, 11627.418629068545, 11760.705982350446, 11782.0, 11455.656330310083, 11508.769824603503, 11530.192886497949, 11530.192886497949, 11536.769264614702, 638.1098367776948, 770.5492287012105, 808.4987307869114, 814.4380377539479, 821.720614990903, 797.956112413817, 807.3702512040618, 809.3686924199134, 809.7368355284526, 811.6266517402003, 838.2372041442288, 847.8389106069858, 849.0829903703985, 849.1508491508491, 849.8937632795901, 660.9966950165267, 679.7484930575719, 684.2712511175582, 809.3323008517996, 833.62903507939, 610.7495926670044, 616.4421198815035, 623.7130919776909, 624.0639041437843, 624.4941597306151, 12195.390230488529, 12311.876881231163, 12316.876831231752, 12322.0, 12352.197107188003, 12318.692032699255, 12652.304123273216, 13040.739185216242, 13049.0, 13153.276569788657, 9108.726738197865, 9131.223845973034, 9136.177744003071, 9342.90657093434, 9352.064793520662, 3036.7722420818304, 3069.2480342316053, 3083.075077476748, 3087.8764849405998, 3158.2262345725217, 47714.0, 48173.518264817256, 48180.0, 48312.0, 48442.0, 9704.902950970541, 9736.123748862636, 9869.0, 9905.752356191153, 10103.292769506212, 17083.31666733317, 17121.315147394213, 17127.05801180947, 17168.656626867643, 17211.225494852762, 6126.754929802847, 6168.25980882297, 6244.0, 6245.875082498415, 6246.781362652377, 3309.8179600121744, 3325.48454989477, 3360.7311415086733, 3416.9829150854584, 3424.280901010816, 2752.683441404224, 2852.0017993702454, 2852.144356693025, 2856.7000464951298, 2858.4140251248446, 462.08507155831643, 470.38614607936285, 480.7307907571771, 493.25025960540495, 500.0199608766858, 512.6155383462403, 550.070381056022, 555.5999680230228, 573.5153795043182, 604.8699529601068, 7468.253174682488, 7499.700011999459, 7579.1662917079075, 7819.843603127905, 7843.960780196063, 457.5630273089192, 494.8011108185597, 511.00354309097406, 524.1351769580147, 575.0827430248746, 3635.2729454109285, 3676.5219822464337, 3685.0603096210293, 3693.372126738461, 3793.6775374093513, 55775.44224557783, 55803.72098139564, 56382.718086410125, 56464.717676411354, 56540.43459565352, 46705.299420508716, 47145.29282060772, 47306.52693473021, 47761.5223847764, 48094.27858582124, 43741.78129109334, 43932.78033609811, 44005.77997109994, 44542.77728611336, 44794.77602611966, 7046.4010559101, 7172.246914073947, 7199.3520583147765, 7199.604021778643, 7341.559506429631, 29129.271768205963, 29464.55803162997, 29821.70178298276, 30261.848690756404, 30433.23916902095, 38167.2366552673, 39384.6061539381, 39404.80297598494, 39523.20953580855, 39976.0, 10073.496325183858, 10116.645917392856, 10143.188544916242, 10326.380417174994, 10407.58369665205, 11825.349605771766, 11941.820872686743, 12132.636020919386, 12146.0, 12857.164284321489, 7525.8118547036765, 9381.249500040118, 10044.698659040241, 10243.282970192015, 11606.187566870576, 9855.35940163887, 10109.19126469866, 10190.745231369276, 10324.48377581103, 10451.111655509367, 10508.369497830156, 10567.418791966209, 10685.57257709683, 10945.781084378426, 11279.379634120201, 9166.11087330918, 9358.251339892928, 9382.812343753223, 9479.099485548863, 9797.167240784613, 8521.190486903733, 8896.733098007071, 9016.954915225382, 9068.546572671208, 9079.636814527345], "value": 5738.517171063603, "unit": "score"}], "name": "dromaeo_css", "value": 6286.170042641135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 108.0, 112.0, 113.0, 112.0, 102.0, 112.0, 112.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 132.0, 161.0, 193.0, 134.0, 159.0, 157.0, 133.0, 188.0, 136.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 125.0, 112.0, 75.0, 75.0, 74.0, 113.0, 99.0, 75.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 139.0, 94.0, 93.0, 93.0, 139.0, 95.0, 93.0, 144.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 80.0, 65.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 78.0, 79.0, 79.0, 81.0, 81.0, 82.0, 81.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 133.0, 134.0, 130.0, 132.0, 130.0, 135.0, 166.0, 132.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 182.0, 175.0, 178.0, 176.0, 174.0, 172.0, 171.0, 171.0, 172.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 72.0, 74.0, 72.0, 71.0, 71.0, 71.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1577.1000000000001, "alertThreshold": 2.0}]} 22:18:08 INFO - Return code: 0 22:18:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:18:08 ERROR - # TBPL SUCCESS # 22:18:08 INFO - Running post-action listener: _resource_record_post_action 22:18:08 INFO - Running post-run listener: _resource_record_post_run 22:18:09 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532561920; Read time: 12; Write time: 553736 22:18:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243351552; Read time: 0; Write time: 282656 22:18:09 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289210368; Read time: 12; Write time: 271080 22:18:09 INFO - Running post-run listener: _upload_blobber_files 22:18:09 INFO - Blob upload gear active. 22:18:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:18:09 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 22:18:09 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'] 22:18:09 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 22:18:10 INFO - (blobuploader) - INFO - Open directory for files ... 22:18:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:18:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:18:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:18:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:18:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:18:11 INFO - (blobuploader) - INFO - Done attempting. 22:18:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:18:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:18:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:18:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:18:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:18:12 INFO - (blobuploader) - INFO - Done attempting. 22:18:12 INFO - (blobuploader) - INFO - Iteration through files over. 22:18:12 INFO - Return code: 0 22:18:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:18:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:18:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e8303c88184795432f0b04d625038dc446b3ccd20b77a4e1b6ea0e148f884285463ff9aaabd10996c5f7fc5f764f3a556a3351281a32c8f9c0502d17c9c2ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e9570196297360947b5749e30659f8b688e76acbb38e879a2da37d8cea5f6755d1827aecd8132f9e8b1fc42a1d93d3b20254fd4288fa17179b0e15487e7f602"} 22:18:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:18:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:18:12 INFO - Contents: 22:18:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/54e8303c88184795432f0b04d625038dc446b3ccd20b77a4e1b6ea0e148f884285463ff9aaabd10996c5f7fc5f764f3a556a3351281a32c8f9c0502d17c9c2ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e9570196297360947b5749e30659f8b688e76acbb38e879a2da37d8cea5f6755d1827aecd8132f9e8b1fc42a1d93d3b20254fd4288fa17179b0e15487e7f602"} 22:18:12 INFO - Running post-run listener: copy_logs_to_upload_dir 22:18:12 INFO - Copying logs to upload dir... 22:18:12 INFO - mkdir: /builds/slave/test/build/upload/logs 22:18:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.978641 ========= master_lag: 563.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 30 mins, 4 secs) (at 2016-04-19 22:27:35.452010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 22:27:35.455441) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879 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/54e8303c88184795432f0b04d625038dc446b3ccd20b77a4e1b6ea0e148f884285463ff9aaabd10996c5f7fc5f764f3a556a3351281a32c8f9c0502d17c9c2ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e9570196297360947b5749e30659f8b688e76acbb38e879a2da37d8cea5f6755d1827aecd8132f9e8b1fc42a1d93d3b20254fd4288fa17179b0e15487e7f602"} build_url:https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/ZC3LQA5-RIiYjXrc6T2F4w/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/54e8303c88184795432f0b04d625038dc446b3ccd20b77a4e1b6ea0e148f884285463ff9aaabd10996c5f7fc5f764f3a556a3351281a32c8f9c0502d17c9c2ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e9570196297360947b5749e30659f8b688e76acbb38e879a2da37d8cea5f6755d1827aecd8132f9e8b1fc42a1d93d3b20254fd4288fa17179b0e15487e7f602"}' ========= master_lag: 0.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 22:27:36.004902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 22 secs) (at 2016-04-19 22:27:36.008256) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1461128163.573736-1715530879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 22.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 22 secs) (at 2016-04-19 22:27:58.363951) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 22:27:58.364281) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 22:27:58.617171) ========= ========= Total master_lag: 586.82 =========