builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1461176173.45 results: success (0) buildid: 20160420103441 builduid: c166b148dc034f398601cae773c0cb63 revision: 50e5abd1f981d784be7300b645188720b88ee8e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.450972) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.453487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.453919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.551057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.551587) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 11:16:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 80.8M=0s 2016-04-20 11:16:14 (80.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.670537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.670855) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013763 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:13.758545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 11:16:13.758958) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 50e5abd1f981d784be7300b645188720b88ee8e9 --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 50e5abd1f981d784be7300b645188720b88ee8e9 --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=a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 11:16:14,600 truncating revision to first 12 chars 2016-04-20 11:16:14,600 Setting DEBUG logging. 2016-04-20 11:16:14,600 attempt 1/10 2016-04-20 11:16:14,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/50e5abd1f981?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 11:16:15,799 unpacking tar archive at: fx-team-50e5abd1f981/testing/mozharness/ program finished with exit code 0 elapsedTime=1.485091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 11:16:15.260565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:15.260890) ========= script_repo_revision: 50e5abd1f981d784be7300b645188720b88ee8e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:15.261339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:15.261626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 11:16:15.271112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-20 11:16:15.271464) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:16 INFO - MultiFileLogger online at 20160420 11:16:16 in /builds/slave/test 11:16:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 11:16:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:16 INFO - {'append_to_log': False, 11:16:16 INFO - 'base_work_dir': '/builds/slave/test', 11:16:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:16:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:16 INFO - 'branch': 'Fx-Team-Non-PGO', 11:16:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:16 INFO - 'config_files': ('talos/linux_config.py',), 11:16:16 INFO - 'default_actions': ('clobber', 11:16:16 INFO - 'read-buildbot-config', 11:16:16 INFO - 'download-and-extract', 11:16:16 INFO - 'populate-webroot', 11:16:16 INFO - 'create-virtualenv', 11:16:16 INFO - 'install', 11:16:16 INFO - 'run-tests'), 11:16:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:16 INFO - 'download_minidump_stackwalk': True, 11:16:16 INFO - 'download_symbols': 'ondemand', 11:16:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:16 INFO - 'installer_path': 'installer.exe', 11:16:16 INFO - 'log_level': 'info', 11:16:16 INFO - 'log_name': 'talos', 11:16:16 INFO - 'log_to_console': True, 11:16:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:16 INFO - 'opt_config_files': (), 11:16:16 INFO - 'pip_index': False, 11:16:16 INFO - 'sps_profile': False, 11:16:16 INFO - 'sps_profile_interval': 0, 11:16:16 INFO - 'suite': 'dromaeojs-e10s', 11:16:16 INFO - 'system_bits': '32', 11:16:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:16 INFO - 'title': 'talos-linux64-ix-064', 11:16:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:16 INFO - 'use_talos_json': True, 11:16:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:16 INFO - 'work_dir': 'build'} 11:16:16 INFO - ##### 11:16:16 INFO - ##### Running clobber step. 11:16:16 INFO - ##### 11:16:16 INFO - Running pre-action listener: _resource_record_pre_action 11:16:16 INFO - Running main action method: clobber 11:16:16 INFO - rmtree: /builds/slave/test/build 11:16:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:17 INFO - Running post-action listener: _resource_record_post_action 11:16:17 INFO - ##### 11:16:17 INFO - ##### Running read-buildbot-config step. 11:16:17 INFO - ##### 11:16:17 INFO - Running pre-action listener: _resource_record_pre_action 11:16:17 INFO - Running main action method: read_buildbot_config 11:16:17 INFO - Using buildbot properties: 11:16:17 INFO - { 11:16:17 INFO - "project": "", 11:16:17 INFO - "product": "firefox", 11:16:17 INFO - "script_repo_revision": "production", 11:16:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:16:17 INFO - "repository": "", 11:16:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:16:17 INFO - "buildid": "20160420103441", 11:16:17 INFO - "pgo_build": "False", 11:16:17 INFO - "basedir": "/builds/slave/test", 11:16:17 INFO - "buildnumber": 1186, 11:16:17 INFO - "slavename": "talos-linux64-ix-064", 11:16:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:16:17 INFO - "platform": "ubuntu64_hw", 11:16:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:16:17 INFO - "branch": "fx-team", 11:16:17 INFO - "repo_path": "integration/fx-team", 11:16:17 INFO - "revision": "50e5abd1f981d784be7300b645188720b88ee8e9", 11:16:17 INFO - "stage_platform": "linux64", 11:16:17 INFO - "builduid": "c166b148dc034f398601cae773c0cb63", 11:16:17 INFO - "slavebuilddir": "test" 11:16:17 INFO - } 11:16:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:16:17 INFO - Running post-action listener: _resource_record_post_action 11:16:17 INFO - ##### 11:16:17 INFO - ##### Running download-and-extract step. 11:16:17 INFO - ##### 11:16:17 INFO - Running pre-action listener: _resource_record_pre_action 11:16:17 INFO - Running main action method: download_and_extract 11:16:17 INFO - mkdir: /builds/slave/test/build/tests 11:16:17 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')]} 11:16:17 INFO - https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:24 INFO - Downloaded 1361 bytes. 11:16:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:16:24 INFO - Using the following test package requirements: 11:16:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:16:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'jsshell-linux-x86_64.zip'], 11:16:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:24 INFO - https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:31 INFO - Downloaded 22267803 bytes. 11:16:31 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'] 11:16:31 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 11:16:32 INFO - Return code: 0 11:16:32 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 11:16: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')]} 11:16:32 INFO - https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:16:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:37 INFO - Downloaded 22267803 bytes. 11:16: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'] 11:16: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 11:16:38 INFO - Return code: 0 11:16: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')]} 11:16:38 INFO - https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:39 INFO - Downloaded 10845952 bytes. 11:16: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'] 11:16: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 11:16:39 INFO - Return code: 0 11:16: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')]} 11:16:39 INFO - https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/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 11:16:43 INFO - Downloaded 54655585 bytes. 11:16:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:43 INFO - mkdir: /builds/slave/test/properties 11:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:43 INFO - Contents: 11:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:16:44 INFO - Running post-action listener: _resource_record_post_action 11:16:44 INFO - Running post-action listener: set_extra_try_arguments 11:16:44 INFO - ##### 11:16:44 INFO - ##### Running populate-webroot step. 11:16:44 INFO - ##### 11:16:44 INFO - Running pre-action listener: _resource_record_pre_action 11:16:44 INFO - Running main action method: populate_webroot 11:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:44 INFO - '--tppagecycles', 11:16:44 INFO - '7'], 11:16:44 INFO - 'tests': ['tsvgm']}}, 11:16:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['damp', 'tps']}, 11:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['damp', 'tps']}, 11:16:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['dromaeo_dom']}, 11:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore', 11:16:44 INFO - 'tabpaint']}, 11:16:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tsvgx', 11:16:44 INFO - 'tsvgr_opacity', 11:16:44 INFO - 'tart', 11:16:44 INFO - 'tscrollx', 11:16:44 INFO - 'cart']}, 11:16:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:44 INFO - 'tsvgr_opacity', 11:16:44 INFO - 'tart', 11:16:44 INFO - 'tscrollx', 11:16:44 INFO - 'cart']}, 11:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s'], 11:16:44 INFO - 'tests': ['tp5o']}, 11:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['tp5o']}, 11:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--disable-e10s', 11:16:44 INFO - '--xperf_path', 11:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:44 INFO - 'tests': ['tp5n']}, 11:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--xperf_path', 11:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:44 INFO - 'tests': ['tp5n']}}, 11:16:44 INFO - 'talos.zip': {'path': '', 11:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:44 INFO - Running post-action listener: _resource_record_post_action 11:16:44 INFO - ##### 11:16:44 INFO - ##### Running create-virtualenv step. 11:16:44 INFO - ##### 11:16:44 INFO - Running pre-action listener: _resource_record_pre_action 11:16:44 INFO - Running main action method: create_virtualenv 11:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16: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 11:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:44 INFO - Using real prefix '/usr' 11:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:46 INFO - Installing pip.................done. 11:16:46 INFO - Return code: 0 11:16:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:46 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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:16:46 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 11:16:46 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 11:16:46 INFO - Using env: {'DISPLAY': ':0', 11:16:46 INFO - 'HOME': '/home/cltbld', 11:16:46 INFO - 'LANG': 'en_US.UTF-8', 11:16:46 INFO - 'LANGUAGE': 'en_US:en', 11:16:46 INFO - 'LOGNAME': 'cltbld', 11:16:46 INFO - 'MAIL': '/var/mail/cltbld', 11:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:46 INFO - 'MOZ_NO_REMOTE': '1', 11:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:46 INFO - 'NO_EM_RESTART': '1', 11:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:46 INFO - 'PWD': '/builds/slave/test', 11:16:46 INFO - 'SHELL': '/bin/bash', 11:16:46 INFO - 'SHLVL': '1', 11:16:46 INFO - 'TERM': 'linux', 11:16:46 INFO - 'TMOUT': '86400', 11:16:46 INFO - 'USER': 'cltbld', 11:16:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:46 INFO - '_': '/tools/buildbot/bin/python'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16: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 11:16:47 INFO - Cleaning up... 11:16:47 INFO - Return code: 0 11:16:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:16: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 11:16: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 11:16:47 INFO - Using env: {'DISPLAY': ':0', 11:16:47 INFO - 'HOME': '/home/cltbld', 11:16:47 INFO - 'LANG': 'en_US.UTF-8', 11:16:47 INFO - 'LANGUAGE': 'en_US:en', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MAIL': '/var/mail/cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SHLVL': '1', 11:16:47 INFO - 'TERM': 'linux', 11:16:47 INFO - 'TMOUT': '86400', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - '_': '/tools/buildbot/bin/python'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:47 INFO - Downloading/unpacking psutil>=0.7.1 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:49 INFO - Installing collected packages: psutil 11:16:49 INFO - Running setup.py install for psutil 11:16:49 INFO - building 'psutil._psutil_linux' extension 11:16: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 11:16:49 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 11:16:49 INFO - building 'psutil._psutil_posix' extension 11:16:49 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 11:16:49 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 11:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:49 INFO - Successfully installed psutil 11:16:49 INFO - Cleaning up... 11:16:49 INFO - Return code: 0 11:16:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:16:49 INFO - Using env: {'DISPLAY': ':0', 11:16:49 INFO - 'HOME': '/home/cltbld', 11:16:49 INFO - 'LANG': 'en_US.UTF-8', 11:16:49 INFO - 'LANGUAGE': 'en_US:en', 11:16:49 INFO - 'LOGNAME': 'cltbld', 11:16:49 INFO - 'MAIL': '/var/mail/cltbld', 11:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:49 INFO - 'MOZ_NO_REMOTE': '1', 11:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:49 INFO - 'NO_EM_RESTART': '1', 11:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:49 INFO - 'PWD': '/builds/slave/test', 11:16:49 INFO - 'SHELL': '/bin/bash', 11:16:49 INFO - 'SHLVL': '1', 11:16:49 INFO - 'TERM': 'linux', 11:16:49 INFO - 'TMOUT': '86400', 11:16:49 INFO - 'USER': 'cltbld', 11:16:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:49 INFO - '_': '/tools/buildbot/bin/python'} 11:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16: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) 11:16:52 INFO - Installing collected packages: mozsystemmonitor 11:16:52 INFO - Running setup.py install for mozsystemmonitor 11:16:52 INFO - Successfully installed mozsystemmonitor 11:16:52 INFO - Cleaning up... 11:16:52 INFO - Return code: 0 11:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:16: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 11:16: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 11:16:52 INFO - Using env: {'DISPLAY': ':0', 11:16:52 INFO - 'HOME': '/home/cltbld', 11:16:52 INFO - 'LANG': 'en_US.UTF-8', 11:16:52 INFO - 'LANGUAGE': 'en_US:en', 11:16:52 INFO - 'LOGNAME': 'cltbld', 11:16:52 INFO - 'MAIL': '/var/mail/cltbld', 11:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:52 INFO - 'MOZ_NO_REMOTE': '1', 11:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:52 INFO - 'NO_EM_RESTART': '1', 11:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:52 INFO - 'PWD': '/builds/slave/test', 11:16:52 INFO - 'SHELL': '/bin/bash', 11:16:52 INFO - 'SHLVL': '1', 11:16:52 INFO - 'TERM': 'linux', 11:16:52 INFO - 'TMOUT': '86400', 11:16:52 INFO - 'USER': 'cltbld', 11:16:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:52 INFO - '_': '/tools/buildbot/bin/python'} 11:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:54 INFO - Downloading docopt-0.6.1.tar.gz 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:54 INFO - Running setup.py install for blobuploader 11:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:55 INFO - Running setup.py install for requests 11:16:55 INFO - Running setup.py install for docopt 11:16:55 INFO - Successfully installed blobuploader requests docopt 11:16:55 INFO - Cleaning up... 11:16:55 INFO - Return code: 0 11:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:55 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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:16:55 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 11:16:55 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 11:16:55 INFO - Using env: {'DISPLAY': ':0', 11:16:55 INFO - 'HOME': '/home/cltbld', 11:16:55 INFO - 'LANG': 'en_US.UTF-8', 11:16:55 INFO - 'LANGUAGE': 'en_US:en', 11:16:55 INFO - 'LOGNAME': 'cltbld', 11:16:55 INFO - 'MAIL': '/var/mail/cltbld', 11:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:55 INFO - 'MOZ_NO_REMOTE': '1', 11:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:55 INFO - 'NO_EM_RESTART': '1', 11:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:55 INFO - 'PWD': '/builds/slave/test', 11:16:55 INFO - 'SHELL': '/bin/bash', 11:16:55 INFO - 'SHLVL': '1', 11:16:55 INFO - 'TERM': 'linux', 11:16:55 INFO - 'TMOUT': '86400', 11:16:55 INFO - 'USER': 'cltbld', 11:16:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:55 INFO - '_': '/tools/buildbot/bin/python'} 11:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:55 INFO - Running setup.py (path:/tmp/pip-kakNgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:55 INFO - Running setup.py (path:/tmp/pip-RDjpya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:55 INFO - Running setup.py (path:/tmp/pip-bHT6BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:56 INFO - Running setup.py (path:/tmp/pip-LwL16i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:56 INFO - Running setup.py (path:/tmp/pip-Zv_AmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:56 INFO - Running setup.py (path:/tmp/pip-v5QBr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:56 INFO - Running setup.py (path:/tmp/pip-cvQKDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:56 INFO - Running setup.py (path:/tmp/pip-0skW7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:56 INFO - Running setup.py (path:/tmp/pip-2akYjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:56 INFO - Running setup.py (path:/tmp/pip-zrD2JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:56 INFO - Running setup.py (path:/tmp/pip-2upmjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:56 INFO - Running setup.py (path:/tmp/pip-PsORbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:56 INFO - Running setup.py (path:/tmp/pip-3OxjQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:56 INFO - Running setup.py (path:/tmp/pip-p5eXJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:56 INFO - Running setup.py (path:/tmp/pip-lAAdBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:56 INFO - Running setup.py (path:/tmp/pip-DcIBy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:56 INFO - Running setup.py (path:/tmp/pip-ML9vMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:57 INFO - Running setup.py install for manifestparser 11:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozcrash 11:16:57 INFO - Running setup.py install for mozdebug 11:16:57 INFO - Running setup.py install for mozdevice 11:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozfile 11:16:57 INFO - Running setup.py install for mozhttpd 11:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozinfo 11:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozInstall 11:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozleak 11:16:57 INFO - Running setup.py install for mozlog 11:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Running setup.py install for moznetwork 11:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Running setup.py install for mozprocess 11:16:58 INFO - Running setup.py install for mozprofile 11:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Running setup.py install for mozrunner 11:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Running setup.py install for mozscreenshot 11:16:58 INFO - Running setup.py install for moztest 11:16:58 INFO - Running setup.py install for mozversion 11:16:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:58 INFO - Cleaning up... 11:16:58 INFO - Return code: 0 11:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:58 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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:16:58 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 11:16:58 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 11:16:58 INFO - Using env: {'DISPLAY': ':0', 11:16:58 INFO - 'HOME': '/home/cltbld', 11:16:58 INFO - 'LANG': 'en_US.UTF-8', 11:16:58 INFO - 'LANGUAGE': 'en_US:en', 11:16:58 INFO - 'LOGNAME': 'cltbld', 11:16:58 INFO - 'MAIL': '/var/mail/cltbld', 11:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:58 INFO - 'MOZ_NO_REMOTE': '1', 11:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:58 INFO - 'NO_EM_RESTART': '1', 11:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:58 INFO - 'PWD': '/builds/slave/test', 11:16:58 INFO - 'SHELL': '/bin/bash', 11:16:58 INFO - 'SHLVL': '1', 11:16:58 INFO - 'TERM': 'linux', 11:16:58 INFO - 'TMOUT': '86400', 11:16:58 INFO - 'USER': 'cltbld', 11:16:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:58 INFO - '_': '/tools/buildbot/bin/python'} 11:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:59 INFO - Running setup.py (path:/tmp/pip-VW9Tg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16: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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:59 INFO - Running setup.py (path:/tmp/pip-OCiNAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16: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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:59 INFO - Running setup.py (path:/tmp/pip-dKbTIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16: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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:59 INFO - Running setup.py (path:/tmp/pip-MbLQQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16: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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:59 INFO - Running setup.py (path:/tmp/pip-pvh0z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16: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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:59 INFO - Running setup.py (path:/tmp/pip-rGSr26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:59 INFO - Running setup.py (path:/tmp/pip-fB9TF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:59 INFO - Running setup.py (path:/tmp/pip-rQHpr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:59 INFO - Running setup.py (path:/tmp/pip-olbf72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:59 INFO - Running setup.py (path:/tmp/pip-k9Wnt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:59 INFO - Running setup.py (path:/tmp/pip-9_mNl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:59 INFO - Running setup.py (path:/tmp/pip-vam1Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:59 INFO - Running setup.py (path:/tmp/pip-idIM18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:59 INFO - Running setup.py (path:/tmp/pip-LL8ChL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17: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)) 11:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:00 INFO - Running setup.py (path:/tmp/pip-5xcD1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17: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)) 11:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:00 INFO - Running setup.py (path:/tmp/pip-RckTQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17: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)) 11:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:00 INFO - Running setup.py (path:/tmp/pip-lL88PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17: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)) 11:17: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)) 11:17: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)) 11:17: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)) 11:17: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)) 11:17: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)) 11:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:02 INFO - Downloading blessings-1.6.tar.gz 11:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:02 INFO - Installing collected packages: blessings 11:17:02 INFO - Running setup.py install for blessings 11:17:02 INFO - Successfully installed blessings 11:17:02 INFO - Cleaning up... 11:17:02 INFO - Return code: 0 11:17:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:02 INFO - Reading from file tmpfile_stdout 11:17:02 INFO - Current package versions: 11:17:02 INFO - argparse == 1.2.1 11:17:02 INFO - blessings == 1.6 11:17:02 INFO - blobuploader == 1.2.4 11:17:02 INFO - docopt == 0.6.1 11:17:02 INFO - manifestparser == 1.1 11:17:02 INFO - mozInstall == 1.12 11:17:02 INFO - mozcrash == 0.17 11:17:02 INFO - mozdebug == 0.1 11:17:02 INFO - mozdevice == 0.48 11:17:02 INFO - mozfile == 1.2 11:17:02 INFO - mozhttpd == 0.7 11:17:02 INFO - mozinfo == 0.9 11:17:02 INFO - mozleak == 0.1 11:17:02 INFO - mozlog == 3.1 11:17:02 INFO - moznetwork == 0.27 11:17:02 INFO - mozprocess == 0.22 11:17:02 INFO - mozprofile == 0.28 11:17:02 INFO - mozrunner == 6.11 11:17:02 INFO - mozscreenshot == 0.1 11:17:02 INFO - mozsystemmonitor == 0.0 11:17:02 INFO - moztest == 0.7 11:17:02 INFO - mozversion == 1.4 11:17:02 INFO - psutil == 3.1.1 11:17:02 INFO - requests == 1.2.3 11:17:02 INFO - wsgiref == 0.1.2 11:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:02 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')]} 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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')]} 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:17:02 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 11:17:02 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 11:17:02 INFO - Using env: {'DISPLAY': ':0', 11:17:02 INFO - 'HOME': '/home/cltbld', 11:17:02 INFO - 'LANG': 'en_US.UTF-8', 11:17:02 INFO - 'LANGUAGE': 'en_US:en', 11:17:02 INFO - 'LOGNAME': 'cltbld', 11:17:02 INFO - 'MAIL': '/var/mail/cltbld', 11:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:02 INFO - 'MOZ_NO_REMOTE': '1', 11:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:02 INFO - 'NO_EM_RESTART': '1', 11:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:02 INFO - 'PWD': '/builds/slave/test', 11:17:02 INFO - 'SHELL': '/bin/bash', 11:17:02 INFO - 'SHLVL': '1', 11:17:02 INFO - 'TERM': 'linux', 11:17:02 INFO - 'TMOUT': '86400', 11:17:02 INFO - 'USER': 'cltbld', 11:17:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:02 INFO - '_': '/tools/buildbot/bin/python'} 11:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 INFO - Cleaning up... 11:17:02 INFO - Return code: 0 11:17:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:02 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')]} 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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')]} 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:17:02 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 11:17:02 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 11:17:02 INFO - Using env: {'DISPLAY': ':0', 11:17:02 INFO - 'HOME': '/home/cltbld', 11:17:02 INFO - 'LANG': 'en_US.UTF-8', 11:17:02 INFO - 'LANGUAGE': 'en_US:en', 11:17:02 INFO - 'LOGNAME': 'cltbld', 11:17:02 INFO - 'MAIL': '/var/mail/cltbld', 11:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:02 INFO - 'MOZ_NO_REMOTE': '1', 11:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:02 INFO - 'NO_EM_RESTART': '1', 11:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:02 INFO - 'PWD': '/builds/slave/test', 11:17:02 INFO - 'SHELL': '/bin/bash', 11:17:02 INFO - 'SHLVL': '1', 11:17:02 INFO - 'TERM': 'linux', 11:17:02 INFO - 'TMOUT': '86400', 11:17:02 INFO - 'USER': 'cltbld', 11:17:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:02 INFO - '_': '/tools/buildbot/bin/python'} 11:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:03 INFO - Downloading/unpacking jsonschema 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:05 INFO - warning: no files found matching '*.txt' 11:17:05 INFO - no previously-included directories found matching 'build' 11:17:05 INFO - no previously-included directories found matching 'dist' 11:17:05 INFO - no previously-included directories found matching '.git*' 11:17:05 INFO - Installing collected packages: jsonschema, functools32 11:17:05 INFO - Running setup.py install for functools32 11:17:05 INFO - warning: no files found matching '*.txt' 11:17:05 INFO - no previously-included directories found matching 'build' 11:17:05 INFO - no previously-included directories found matching 'dist' 11:17:05 INFO - no previously-included directories found matching '.git*' 11:17:05 INFO - Successfully installed jsonschema functools32 11:17:05 INFO - Cleaning up... 11:17:05 INFO - Return code: 0 11:17:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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 0x7fd9e0d97f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', '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 11:17: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 11:17: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 11:17:05 INFO - Using env: {'DISPLAY': ':0', 11:17:05 INFO - 'HOME': '/home/cltbld', 11:17:05 INFO - 'LANG': 'en_US.UTF-8', 11:17:05 INFO - 'LANGUAGE': 'en_US:en', 11:17:05 INFO - 'LOGNAME': 'cltbld', 11:17:05 INFO - 'MAIL': '/var/mail/cltbld', 11:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:05 INFO - 'MOZ_NO_REMOTE': '1', 11:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:05 INFO - 'NO_EM_RESTART': '1', 11:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:05 INFO - 'PWD': '/builds/slave/test', 11:17:05 INFO - 'SHELL': '/bin/bash', 11:17:05 INFO - 'SHLVL': '1', 11:17:05 INFO - 'TERM': 'linux', 11:17:05 INFO - 'TMOUT': '86400', 11:17:05 INFO - 'USER': 'cltbld', 11:17:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:05 INFO - '_': '/tools/buildbot/bin/python'} 11:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:05 INFO - Downloading/unpacking flake8 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:17:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:17:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:17:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:08 INFO - no previously-included directories found matching 'docs/_build' 11:17:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:17:08 INFO - Running setup.py install for pep8 11:17:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:08 INFO - no previously-included directories found matching 'docs/_build' 11:17:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:17:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:17:08 INFO - Cleaning up... 11:17:08 INFO - Return code: 0 11:17:08 INFO - Running post-action listener: _resource_record_post_action 11:17:08 INFO - Running post-action listener: _start_resource_monitoring 11:17:08 INFO - Starting resource monitoring. 11:17:08 INFO - ##### 11:17:08 INFO - ##### Running install step. 11:17:08 INFO - ##### 11:17:08 INFO - Running pre-action listener: _resource_record_pre_action 11:17:08 INFO - Running main action method: install 11:17:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:08 INFO - Reading from file tmpfile_stdout 11:17:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:08 INFO - Reading from file tmpfile_stdout 11:17:08 INFO - Output received: 11:17:08 INFO - Usage: mozinstall [options] installer 11:17:08 INFO - Options: 11:17:08 INFO - -h, --help show this help message and exit 11:17:08 INFO - -d DEST, --destination=DEST 11:17:08 INFO - Directory to install application into. [default: 11:17:08 INFO - "/builds/slave/test"] 11:17:08 INFO - --app=APP Application being installed. [default: firefox] 11:17:08 INFO - mkdir: /builds/slave/test/build/application 11:17:08 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'] 11:17:08 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 11:17:24 INFO - Reading from file tmpfile_stdout 11:17:24 INFO - Output received: 11:17:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:24 INFO - Running post-action listener: _resource_record_post_action 11:17:24 INFO - ##### 11:17:24 INFO - ##### Running run-tests step. 11:17:24 INFO - ##### 11:17:24 INFO - Running pre-action listener: _resource_record_pre_action 11:17:24 INFO - Running main action method: run_tests 11:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:24 INFO - Python 2.7.3 11:17:24 INFO - Return code: 0 11:17:24 INFO - grabbing minidump binary from tooltool 11:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:24 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 0x241c410>, '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 0x241d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:24 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 11:17:24 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 11:17:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:24 INFO - Return code: 0 11:17:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:17:25 INFO - Return code: 0 11:17:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:17:25 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:17:25 INFO - Using env: {'DISPLAY': ':0', 11:17:25 INFO - 'HOME': '/home/cltbld', 11:17:25 INFO - 'LANG': 'en_US.UTF-8', 11:17:25 INFO - 'LANGUAGE': 'en_US:en', 11:17:25 INFO - 'LOGNAME': 'cltbld', 11:17:25 INFO - 'MAIL': '/var/mail/cltbld', 11:17:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:25 INFO - 'MOZ_NO_REMOTE': '1', 11:17:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:25 INFO - 'NO_EM_RESTART': '1', 11:17:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:25 INFO - 'PWD': '/builds/slave/test', 11:17:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:25 INFO - 'SHELL': '/bin/bash', 11:17:25 INFO - 'SHLVL': '1', 11:17:25 INFO - 'TERM': 'linux', 11:17:25 INFO - 'TMOUT': '86400', 11:17:25 INFO - 'USER': 'cltbld', 11:17:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487', 11:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:25 INFO - '_': '/tools/buildbot/bin/python'} 11:17:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:17:25 INFO - mozversion application_buildid: 20160420103441 11:17:25 INFO - mozversion application_changeset: 50e5abd1f981d784be7300b645188720b88ee8e9 11:17:25 INFO - mozversion application_display_name: Nightly 11:17:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:25 INFO - mozversion application_name: Firefox 11:17:25 INFO - mozversion application_remotingname: firefox 11:17:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:17:25 INFO - mozversion application_vendor: Mozilla 11:17:25 INFO - mozversion application_version: 48.0a1 11:17:25 INFO - mozversion platform_buildid: 20160420103441 11:17:25 INFO - mozversion platform_changeset: 50e5abd1f981d784be7300b645188720b88ee8e9 11:17:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:25 INFO - mozversion platform_version: 48.0a1 11:17:25 INFO - using testdate: 1461176245 11:17:25 INFO - actual date: 1461176245 11:17:25 INFO - starting webserver on 'localhost:47928' 11:17:25 INFO - SUITE-START | Running 2 tests 11:17:25 INFO - TEST-START | dromaeo_css 11:17:25 INFO - operating with platform_type : linux_ 11:17:25 INFO - Initialising browser for dromaeo_css test... 11:17:25 INFO - TEST-INFO | started process 20989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGFHDt/profile http://localhost:47928/getInfo.html) 11:17:30 INFO - PROCESS | 20989 | 11:17:30 INFO - PROCESS | 20989 | (process:21057): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:17:30 INFO - PROCESS | 20989 | __metrics Screen width/height:1600/1200 11:17:30 INFO - PROCESS | 20989 | colorDepth:24 11:17:30 INFO - PROCESS | 20989 | Browser inner width/height: 1024/697 11:17:30 INFO - PROCESS | 20989 | __metrics 11:17:32 ERROR - PROCESS | 20989 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:17:33 INFO - TEST-INFO | 20989: exit 0 11:17:33 INFO - Browser initialized. 11:17:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:33 INFO - TEST-INFO | started process 21110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGFHDt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:35 INFO - PROCESS | 21110 | 11:17:35 INFO - PROCESS | 21110 | (process:21171): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:17:45 INFO - PROCESS | 21110 | RSS: Main: 164909056 11:17:45 INFO - PROCESS | 21110 | 11:18:34 INFO - PROCESS | 21110 | 1461176314686 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] 11:20:46 INFO - PROCESS | 21110 | Cycle 1(1): loaded http://localhost:47928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47928/tests/dromaeo/cssquery-ext.html) 11:20:47 INFO - PROCESS | 21110 | RSS: Main: 169127936 11:20:47 INFO - PROCESS | 21110 | 11:23:49 INFO - PROCESS | 21110 | Cycle 1(1): loaded http://localhost:47928/tests/dromaeo/cssquery-ext.html (next: http://localhost:47928/tests/dromaeo/cssquery-jquery.html) 11:23:50 INFO - PROCESS | 21110 | RSS: Main: 168353792 11:23:50 INFO - PROCESS | 21110 | 11:26:52 INFO - PROCESS | 21110 | Cycle 1(1): loaded http://localhost:47928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47928/tests/dromaeo/cssquery-mootools.html) 11:26:52 INFO - PROCESS | 21110 | RSS: Main: 167063552 11:26:52 INFO - PROCESS | 21110 | 11:29:54 INFO - PROCESS | 21110 | Cycle 1(1): loaded http://localhost:47928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47928/tests/dromaeo/cssquery-prototype.html) 11:29:55 INFO - PROCESS | 21110 | RSS: Main: 164507648 11:29:55 INFO - PROCESS | 21110 | 11:32:57 INFO - PROCESS | 21110 | Cycle 1(1): loaded http://localhost:47928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47928/tests/dromaeo/cssquery-yui.html) 11:32:58 INFO - PROCESS | 21110 | RSS: Main: 165568512 11:32:58 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | Cycle 1(1): loaded http://localhost:47928/tests/dromaeo/cssquery-yui.html (next: http://localhost:47928/tests/dromaeo/cssquery-dojo.html) 11:36:01 INFO - PROCESS | 21110 | RSS: Main: 168013824 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | __start_tp_report 11:36:01 INFO - PROCESS | 21110 | _x_x_mozilla_page_load 11:36:01 INFO - PROCESS | 21110 | _x_x_mozilla_page_load_details 11:36:01 INFO - PROCESS | 21110 | |i|pagename|runs| 11:36:01 INFO - PROCESS | 21110 | |0;dojo.html;2605.101240072175;2662.986685066574;2698.8245764025337;2699.7030326664076;2718.6601674790663;4794.47260801312;4813.061453016663;4830.44449888263;4841.055994081155;4897.608191344692;4751.928721069178;4794.6404019698575;4804.303376010476;4807.735574543408;4811.278308253755;4317.28764753816;4403.427554417921;4440.555944405566;4479.48485924118;4537.591616754491;4458.821647134111;4486.214912390335;4488.932666010012;4496.9325460118125;4532.388127602764;4343.04453020335;4452.621527170194;4482.439695038121;4497.797599108048;4516.18708632446;4421.314696222091;4441.533638967894;4448.377227188196;4481.574250446202;4491.079328737601;4467.106578684276;4480.955190448087;4488.708233964782;4501.482329532113;4543.250363689987;4685.2972054191805;4697;4735.644826637981;4766.165920963817;4822.590079843218;5137.2037334213255;5158.303629010074;5167.7932882684645;5191.221316802472;5192.532672059495;5023.095842748304;5185.455527169631;5190.351206099238;5191.143461328877;5202.06362854686;4890.24201248807;4915.557599815962;4927.1131196384995;4939.185034469308;4964.280179374043;5330.253764472977;5336.893262134736;5356.464353564613;5381.273528073738;5390.245365648812;4929.556339929351;5074.112030394666;5089.8727531812;5101.132807422747;5136.332276803992;5116.923246151311;5143.022825663112;5154.742262886841;5157.432682404932;5230.34620672416;5096.439391666913;5103.591712662978;5110.821121260812;5132.409772876093;5145.691258524501;4965.155923493015;5055.09008378488;5096.108181068298;5096.286519887219;5142.202958541432;3857.517810273716;3949.743266687656;3960.1881614269005;4009.077912080238;4037.818298176589;3510.2452972611013;3529.8235088245483;3592.9580421677942;3607.494950706903;3653.451982202691;4529.954700452953;4542.613877820422;4554.339620754972;4564.885877853014;4595.333676616872;5050.570701490415;5142.228665700175;5185.248139019896;5241.030409374278;5242.030224408497;4482.238019536687;4482.417285752831;4495.056038232008;4520;4555.863324100216;4520.4801447833925;4629.305604159403;4633.189191891473;4644.535546445329;4684.929726054112;4882.389701287339;4888.120138374984;4922.064807686528;4927.457979622311;4949.678270912451;5168.198929165986;5210.426853046238;5264.657797243167;5264.815731449381;5314.22943673173;4784.234522476387;4853.611711063036;4899.706017638953;4949.406071271471;4959.181735013683;5130.640855140105;5143.3570803649545;5144.897102058013;5158.484151584811;5206.088934436534;5217.791288348575;5228.790848366023;5236.083685354972;5241.528262456397;5271.578273738015;4881.365422495053;4959.652824302264;5005.1241032819835;5070.797168113234;5086.694798312114;5011.123053465702;5027.773750181177;5030.0945829751;5038;5071.036503064406;4915.361003069578;4936.802527898843;4938.703677779345;4953.975230123826;4993.975030124826;4907.607391408607;5053.26727624485;5106.770195341144;5113.105206588758;5146.176611742103;4816.638752093537;4974.403071631427;5041.42023667283;5055.292259083658;5103.923441148311 11:36:01 INFO - PROCESS | 21110 | |1;ext.html;564.5511818104607;605.8818530386575;609.5854818723269;626.3767551286471;638.5179189711766;36018.639813601854;37442.43836342457;37505.24989500208;37571.81214093933;37650;38698.226035479274;39134.608653913456;39226.607733922654;39252.21495570087;39263.21473570534;7574.848503029936;7791;7825.6087195640275;7830.843383132334;7833.451658383916;7641.579713115776;7695.115061767884;7725.72959946402;7741.148473667892;7755.767326980172;7757.107932587768;7824.5696486693205;7842.254985776371;7866.606669666522;7886.32966197871;7718.266764657348;7773.378129749634;7813.648385822623;7841.098273698541;7841.372690184771;7732.768016959444;7836.412269079842;7838.059432868093;7838.372930165573;7856.489328193649;29083.709162908523;36211;36606.816965915;36691.266174676624;36717.26565468676;3090.103869877733;3125.937481250385;3235.919102022445;3259.820709860957;3274.9345013099605;23818;24141.517169656683;24160;24662.13682521121;25007.62488562673;3237.2806842252385;3312.7018568328967;3346.0965539304493;3391.5251864738957;3401.897943061712;184960;185380;185836;186079;186464;32100.197495062344;32288.515672264934;32332.676673233436;32900.67099329024;34018.48972265418;32030.359392812014;32041.839790800896;32068.358632827214;32087.839560802513;32213.838930805196;12277.324747138815;12368.567100151631;12462.937685311515;12463;12529.122961392615;10082.49587520621;10123.1901447884;10129.189664826796;10161.949190254149;10171.28800983924;8133.59332033396;8135.430519863553;8159.184081591912;8206.958965205136;8234.135415781377;3173.4763763979145;3207.9839600801847;3216.9195770105466;3236.417444859948;3289.5394644749276;939.9624015039321;954.3510412919143;977.3793641037992;1003.0370843989706;1102.9944850275697;28358;28560.42879142447;28739.27564346146;28958.85520572426;29198.416031679248;1047.1518070363031;1067.7384040910026;1075.7095584192225;1111.2054880760295;1154.3362566524281;14882.181480018486;15148;15150.54548363551;15513.146776927377;15560.688786224213;344561;414613;433220;433985;433990;49021;50232.74883625558;50277.74861125671;50288.748556256985;50430;1170.4206417823232;1277.8786015328528;1281.2312612432652;1283.8651941546377;1287.6523338698687;27390.315242119108;28692.282692932844;29193.85403072971;29287.853560732914;29487;42557.5744242566;43471;43607.34588981231;43631;43633.781831090644;318821;318877;320564;321105;321923;25203.873980629978;25940.8702956484;25978.220653380427;25982;38165.4275185878;36365.63634363622;36748.44877326896;37092.443613345284;37264.06839829026;37629.247415052094;34224;34805.47791783176;34993;35810.28379432449;35928.101797455274;33673.15817104592;34416.48375274423;34613.13467163341;34630;34701.47947780836;31389.372212556078;35157;37846.43230351602;38935.22129557336;40913.1817363657;30658.080257592308;31575.21061973469;31843.84078079595;32079;32294.677053230105;24152.154674586305;25225.11712090068;25236.24291271265;25783.484330312913;25803.870980644977 11:36:01 INFO - PROCESS | 21110 | |2;jquery.html;383.6182997917072;383.83878770916215;392.1725159912584;394.58174335204683;398.7169109931948;12826.935865320684;15501.844981550195;15507;16366.345346186139;16382.672346553076;15825.762613560777;15903.363865445397;16213.270402831871;17220.225089870954;17409.390671326506;4496.415465989417;5035.219540971137;5102.336696229485;5207.270982062514;5250.396204436482;5022.974885125569;5112.872178195537;5124.282600435942;5126.026055049529;5141.948580514203;5047.2176812593925;5123.769430375623;5129.53834154926;5129.948700512984;5145.897082058356;4973.801047958095;5096.133657278272;5102.948970510303;5132.615053870974;5143.254228136918;4429.446319210098;4604.769761511911;4606.447226332828;4606.585407313358;4610.446746390421;20272.290469833486;20527.692084618742;20616.484587885272;20622.072006759732;21021.89489052545;2014.5165160361555;2077.542940553076;2087.9478013049643;2281.178775640768;2543.885525151373;12812.359382030954;12978.675533111653;13007.089503734742;13008.349582520836;13661.043726939119;1770.3272756352633;1800.2528950485532;1802.8467580255694;1803.4589623113013;1863.0032932381246;67403.66298168527;69295;70053;70088.99999999949;70211;9542.42745435276;9754.804903901882;9834.114929656365;9977.25170612207;10069.007378366447;12059.095567832448;12701.174423662433;13704;13769.449222031006;13893.235872027135;6866;7032.156141263081;7085.89371159433;7239.855202895913;7264.237255088246;6544.934550654528;6580.63806490638;6742.6291553965;6906.309369063053;6938.236793952661;6102.816915492543;6124.418180272956;6207.099970504251;6246.937530624636;6298.874022519615;1803.107461806388;1837.503873954025;1850.3893715073993;1856.5822689894665;1884.7738271407245;826.4173757501068;892.4377642085444;958.9664361747306;983.3460748602099;1059.7350662334416;15847.286872090783;16924.238409271366;17330;17381.32311254858;18128.546786330182;877.7015814623059;880.3573391424168;892.054422312351;928.9117533834275;951.3103000324847;9437.575309111107;9572.186364159124;9600.855987160197;9638.855417168748;9774.218062554979;405176;423129;438794;441722;441943;79092.20907790848;82129.58935205286;82743.5862820694;85331.57334213289;88463;915.1260546178383;980.6567701304486;983.8524221366853;1003.3327836988467;1033.9711986573407;14639;15145.015573987655;15291.388344466097;15317.693646126792;15565.221738912782;24587.75412245926;27000.594991074755;30941.381172375975;33089;34310.65689343175;43458.56541434672;43896.34155487734;44338.334924975505;45211.32183017192;50028;7634.961825190839;7700.422468314787;7823.335016523659;7950.284474397332;7990.760277191694;10911.049707223146;12311.322877241837;12363.32001739913;12410.255384676948;12447;10569.471526423802;10584.8941510587;10810.945945270223;10814.56741730322;10864.172884486003;10244.795104097728;10525;10610.416427096583;10694.73263168427;11114.166437517057;10704.30422022566;10839.837402439127;10928.781424371628;11000.394978276272;11067.72773787171;7803.297703206738;7860.3318717909615;7887.921120788718;7924.4056695746895;7955.443118981616;9167.358284919992;10685.465726713477;10844;10867.673969780919;10875.673729788119 11:36:01 INFO - PROCESS | 21110 | |3;mootools.html;1442.077070674768;1477.6675248069182;1612.5243053299275;1766.929322827087;1789.686804809158;6865.382115609594;7501.137369202544;7609.771706848804;7745.380369570435;7819.2571705688015;7561.848763024736;7596.582187979673;7626.046744156981;7645.579493127876;7658.119316278629;2204.4378683435743;2244.708187935566;2253.6281513550325;2259.5819773341987;2262.2082271205027;2186.693862859201;2212.524307273936;2220.711307530019;2222.022310183514;2223.966640500386;2190.8904554772275;2198.4064302638276;2208.624533829253;2222;2243.170027089971;2126.9361919142452;2171.4679903423685;2178.1505212966954;2178.4662757624405;2178.8365872559543;2143.228437762404;2144.613969485492;2153.1710291537715;2153.752318483379;2155.8490905636613;7767.572783496906;7830.334421574116;7849.4897831640765;7876.960615196887;7916.960415197887;4471.575200355994;4642.257238841803;4645.303204519315;4660.091282199973;4669.089527542131;2851.4154598307505;2911.5195992661183;2971.450281697871;2985.000024991609;2987.656419511762;926;963.3834346018554;983.2920297385871;989.5101924547395;993.7366597851575;10163.4918254087;10322.174226061898;10323.535440905178;10334;10364.740881477948;4153.1070819773895;4192.434021407071;4280.657547396201;4381.474223093249;4402.053558484941;8852.557372131369;8897.599608017656;8911.108889111038;8955.05971872957;8959.776005599912;4728.267118596623;4747.216709242936;4757.381540399795;4763.476017638057;4784.6889952153;3726.8136593170234;4167.2082304362075;4287.3140297552245;4298.806553705091;4301.548337424588;3607.4408466687705;3627.220147668264;3722.3299806034634;3730.291244663505;3736.1220113273357;1228.6498347970785;1241;1247.089624574066;1258.2513404524293;1263.2294300476701;921.5162039928957;928.3037721708719;931.5063016601213;933.7338858425452;938.9295802814817;5378.112611419072;5528.474794894559;5544.667319960815;5623.381428042912;5728.455796699307;910.9453432794054;925.8379783537854;928.1229238369676;931.6785708930408;962.2879069488528;3735.327641024587;3852.4799152114665;3897.707671924617;3921.9607803922167;3928.607139286106;9339.392939458914;9724.465154416575;9727.805443891082;9776;9801.607935682492;9634.90365096354;9708.883478399934;9733.464659443798;9747.756306092262;9751.902480975099;7262.20115787263;7272.3818475429125;7300.269973002657;7339.449541284425;7356.926430735732;5296.099663057213;5371.838844834661;5373.946260537501;5407.53996420972;5413.025655382069;8752.64989400417;8765.07966663491;8808.91191088081;8809.163129502687;8879.911200888168;8680.869786953326;8864.911350886408;9001.459912405277;9074.092590740873;9080.364374493722;5754.309482861916;6220.160278362544;6223.190985171898;6367.808965731036;6449.129367535323;7385.741499047507;7413;7440.2931721486375;7450.403967682681;7491.8501629966;6356.936430635819;6676.399124078856;6695.933040669531;6714.227863795726;6769.3907548320885;6900.2409734930125;6902.378785909293;6902.689378978059;6981.650917454005;6987.196472405535;6405.615663060231;6431.48548116159;6449.774257900951;6466.321036291121;6477.4170324671;4715.599174070242;4746.1694203514935;4838.104950584153;4852.539008794159;4859.416869975485;4811.542903424169;4869.756512174306;4898.9957058803575;4967.82612608557;4985.9501404985485 11:36:01 INFO - PROCESS | 21110 | |4;prototype.html;307.4880324260107;313.61268832991254;315.0941044497072;315.5597940872482;318.7927846899515;5302.522772950439;5334.546563542094;5353.785848566057;5371.57027437805;5444.8366549003595;5293.947060529394;5305.389880163782;5324.5740340772745;5327.200919862023;5327.227552004967;3903.687704983609;3922.882313530599;4076.449679293302;4083.612056854594;4102.548719640837;4106.137711080677;4137.8965525861795;4138.33786594145;4139.606737359961;4148.439960605325;4106.486689163855;4109.876703698894;4113.095119073799;4114.444549985744;4115.42384066231;4035.315243415811;4059.0867054912705;4106.876793696164;4106.876793696194;4111.691623128248;3579.0873327301633;3595.334863050344;3597.3344931187553;3598.6941110005682;3602.5316708827945;5050.823221187241;5061.392632884077;5063.215201643714;5070.366204224472;5104.259882317043;4653.790579423934;4746.382970213885;4761.40482439695;4778.784954677048;4782.641301902337;5557.555395568385;5569.526590239834;5586.078297080977;5589.245451863987;5613;3988.202359528106;3995.680345572347;4000.7799571023584;4003.599640035973;4023.094803669151;5688.175214593902;5868.853278668067;5881.764729410861;5887.293524777011;5891.3814049525035;4088.6490268095963;4091.4476545665952;4093.7748423836974;4096.139810639799;4110.403991421227;4152.44624555902;4157.605027522381;4173.1862286853775;4179.6029377209115;4180.602842729936;4633.86098417048;4737.478877323491;4741.004389078264;4741.122892264942;4774.116788394089;5625.46558076982;5625.493705566519;5637.605367624309;5642.407547207484;5689.175069614883;1437.5687293811814;1465.5090544667441;1468.6255004973877;1469.2653673163418;1470.2354775516671;925.3707478914403;963.6675347005272;969.3699095587924;988.5452691761726;1005.2812239248972;4845.442774080955;4849.733264670477;4850.223964165716;4869.586085182728;4911.45973942866;5700.429957004267;5730.1404789281105;5754.942450575524;5760.251167348218;5761.48146666802;4745.240761478216;4823.686460380064;4875.146849301358;4904.2643603459765;4928.950710492849;3079.3071558899514;3088.9382212355627;3089.6910308969373;3102.674219206996;3116.0807561769334;5366.329208848894;5371.650842695212;5373;5375.6774593524515;5377.5160235578205;5732.77068917247;5900.64596124234;5919.496842768327;5922.082077278029;5922.608187076034;5358.3837858645975;5361.544268737123;5385.461453854583;5387.515123638891;5406.621536492407;5531.446855314436;5696.658200507983;5725.398833122629;5729;5745.368009518866;5673.517750991212;5683.5100270785615;5685.431456854281;5686.829395118153;5699.116636921284;5392.757325920422;5398.1902714593125;5414.3232095988005;5425.83722488326;5456.454354564512;3779.4708740776864;3954.4661470701085;3989.8404063838284;4135.937960930528;4154.667626589926;5820.214271073351;5830.338353569213;5837.795677151279;5875.294964604275;5877.089051197071;5603.74783134768;5619.747111379916;5627.774889004394;5633.492985631149;5639.520640745583;5486.698231597141;5591.04952158126;5643.492085712305;5647.604667673223;5665.66006039639;5249.921251181312;5536.557075434036;5552.194931734956;5553.444655534414;5569.443055694398;5494.835154945358;5640.661560306395;5681.602287839812;5715.485606295453;5727.914081288867;5435.646682965595;5447;5474.644148130359;5482.205080263259;5514.862128446821 11:36:01 INFO - PROCESS | 21110 | |5;yui.html;664.6211659354167;678.5080816408104;694.4513834071084;791.0823444804025;805.4321703199245;11663.41682915855;12319;12631.989440844722;12642.494300228003;12653.936730316336;13573;13605.591832245023;13646.795298070538;13699.520516781915;13716;807.2573232625969;813.2233716800441;814.5560669435172;815.6533473273864;815.9306458950966;643.3694978920661;789.3369569561568;814.1898810683349;815.5636734347125;816.6814942172557;850.8766228896807;852.9189726975927;858.2618947704968;860.0539406652695;861.6165806216205;845.9915400845974;848.9278411335013;849.2611428057568;850.3877208409934;852.6845067325129;620.6245221640933;623.8128561431598;624.0981781325986;624.1636207481996;624.1854380034054;11926.582569610022;12019.819702704466;12038.638840834788;12039.518419263219;12040.939795301056;12492;12695.74608507834;12728.490860365575;12731.490740370375;12864.620045291558;10235.6417525387;10479.476026198736;10509.421981790998;10558.52486638103;10934.781304373948;3345.381104495676;3373.2241584435474;3383.4924761285756;3400.404929137416;3469.3755124077657;46903.53096469026;47216.52783472156;47301.763491182326;47455.52544474546;47831.282530762066;9736.513174341255;9949.154321882575;9979.650712225037;10000.199984001263;10027.04743049409;17298.135093245288;17312.22095005728;17324.566885827702;17420.912895435442;17474.65050698979;6573.934260657428;6612.570182938093;6675.432588229958;6681.699323530453;6771.052052712625;3815.4467602197524;3864.072622570563;3905.7851818150275;3917.2948869203815;3941.5664276929515;2927.9707202928125;3041.163679988021;3149.7715890802606;3312.585926759155;3330.500424936279;581.340178896955;589.4989259129705;589.7375667827775;592.8043745563954;594.3610618585038;484.295350265363;626.8871603111393;627.8399008252866;642.7975187815823;663.7577284291199;7674.769756907302;7858.292753652198;7884.526928384201;8057.395695322874;8058.194180582012;610.8472881779555;615.9168512250878;626.3579830673505;628.8490762217035;630.2972186012563;3774.8678796241998;3827.8468861245797;3867.207222519377;3908.6286802753693;3935.7244992850224;52129.739351303004;52691.209631855556;52708.73645631824;52780.94438111216;52793.2081018785;47166.292505612444;47410.28884566734;47436;47860;48821.75589122032;43574.7821260898;43947.78026109849;44356.778216108716;44721.55278447239;45085.323720144224;7234.240404757425;7248.710051597877;7628.961855190689;7651.120121186135;7698.2686644768655;30194.09417717472;30234.24414389658;30281.848590756905;30419.39161216719;30606.08181754551;33556.83221583877;34288.314233714686;36187;38977;40811.79594102011;9951;10060;10085.848712269175;10321.432321222404;10516.57933682644;11610.88389116098;11714.88285117172;11736.650285217309;11892;12279.140460167702;11343.319400835977;11711.531538738354;11918.344491053076;11924.463399146885;12012.089382153366;11382.089432845187;11868.643940681794;11885.049196064467;12043.518259269882;12093.516259349528;10696.83954740664;10768.784624307627;10773.138148948223;10810.29733067348;10981.835272471078;9454.669086582211;9780.657676981271;9948.950255248967;10013.949930250303;10223.182145428496;9488.193503552275;9989.800203995734;10061.496925153859;10224.744381390525;10318.742031449274 11:36:01 INFO - PROCESS | 21110 | __end_tp_report 11:36:01 INFO - PROCESS | 21110 | __start_cc_report 11:36:01 INFO - PROCESS | 21110 | _x_x_mozilla_cycle_collect,369 11:36:01 INFO - PROCESS | 21110 | __end_cc_report 11:36:01 INFO - PROCESS | 21110 | __startTimestamp1461177361481__endTimestamp 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | ------- Summary: start ------- 11:36:01 INFO - PROCESS | 21110 | Number of tests: 6 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | [#0] dojo.html Cycles:165 Average:4766.95 Median:4927.11 stddev:533.99 (10.8%) stddev-sans-first:507.98 11:36:01 INFO - PROCESS | 21110 | Values: 2605.1 2663.0 2698.8 2699.7 2718.7 4794.5 4813.1 4830.4 4841.1 4897.6 4751.9 4794.6 4804.3 4807.7 4811.3 4317.3 4403.4 4440.6 4479.5 4537.6 4458.8 4486.2 4488.9 4496.9 4532.4 4343.0 4452.6 4482.4 4497.8 4516.2 4421.3 4441.5 4448.4 4481.6 4491.1 4467.1 4481.0 4488.7 4501.5 4543.3 4685.3 4697.0 4735.6 4766.2 4822.6 5137.2 5158.3 5167.8 5191.2 5192.5 5023.1 5185.5 5190.4 5191.1 5202.1 4890.2 4915.6 4927.1 4939.2 4964.3 5330.3 5336.9 5356.5 5381.3 5390.2 4929.6 5074.1 5089.9 5101.1 5136.3 5116.9 5143.0 5154.7 5157.4 5230.3 5096.4 5103.6 5110.8 5132.4 5145.7 4965.2 5055.1 5096.1 5096.3 5142.2 3857.5 3949.7 3960.2 4009.1 4037.8 3510.2 3529.8 3593.0 3607.5 3653.5 4530.0 4542.6 4554.3 4564.9 4595.3 5050.6 5142.2 5185.2 5241.0 5242.0 4482.2 4482.4 4495.1 4520.0 4555.9 4520.5 4629.3 4633.2 4644.5 4684.9 4882.4 4888.1 4922.1 4927.5 4949.7 5168.2 5210.4 5264.7 5264.8 5314.2 4784.2 4853.6 4899.7 4949.4 4959.2 5130.6 5143.4 5144.9 5158.5 5206.1 5217.8 5228.8 5236.1 5241.5 5271.6 4881.4 4959.7 5005.1 5070.8 5086.7 5011.1 5027.8 5030.1 5038.0 5071.0 4915.4 4936.8 4938.7 4954.0 4994.0 4907.6 5053.3 5106.8 5113.1 5146.2 4816.6 4974.4 5041.4 5055.3 5103.9 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | [#1] ext.html Cycles:180 Average:44358.63 Median:18532.34 stddev:84998.45 (458.6%) stddev-sans-first:85173.29 11:36:01 INFO - PROCESS | 21110 | Values: 564.6 605.9 609.6 626.4 638.5 36018.6 37442.4 37505.2 37571.8 37650.0 38698.2 39134.6 39226.6 39252.2 39263.2 7574.8 7791.0 7825.6 7830.8 7833.5 7641.6 7695.1 7725.7 7741.1 7755.8 7757.1 7824.6 7842.3 7866.6 7886.3 7718.3 7773.4 7813.6 7841.1 7841.4 7732.8 7836.4 7838.1 7838.4 7856.5 29083.7 36211.0 36606.8 36691.3 36717.3 3090.1 3125.9 3235.9 3259.8 3274.9 23818.0 24141.5 24160.0 24662.1 25007.6 3237.3 3312.7 3346.1 3391.5 3401.9 184960.0 185380.0 185836.0 186079.0 186464.0 32100.2 32288.5 32332.7 32900.7 34018.5 32030.4 32041.8 32068.4 32087.8 32213.8 12277.3 12368.6 12462.9 12463.0 12529.1 10082.5 10123.2 10129.2 10161.9 10171.3 8133.6 8135.4 8159.2 8207.0 8234.1 3173.5 3208.0 3216.9 3236.4 3289.5 940.0 954.4 977.4 1003.0 1103.0 28358.0 28560.4 28739.3 28958.9 29198.4 1047.2 1067.7 1075.7 1111.2 1154.3 14882.2 15148.0 15150.5 15513.1 15560.7 344561.0 414613.0 433220.0 433985.0 433990.0 49021.0 50232.7 50277.7 50288.7 50430.0 1170.4 1277.9 1281.2 1283.9 1287.7 27390.3 28692.3 29193.9 29287.9 29487.0 42557.6 43471.0 43607.3 43631.0 43633.8 318821.0 318877.0 320564.0 321105.0 321923.0 25203.9 25940.9 25978.2 25982.0 38165.4 36365.6 36748.4 37092.4 37264.1 37629.2 34224.0 34805.5 34993.0 35810.3 35928.1 33673.2 34416.5 34613.1 34630.0 34701.5 31389.4 35157.0 37846.4 38935.2 40913.2 30658.1 31575.2 31843.8 32079.0 32294.7 24152.2 25225.1 25236.2 25783.5 25803.9 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | [#2] jquery.html Cycles:180 Average:25377.17 Median:241126.28 stddev:70875.47 (29.4%) stddev-sans-first:71049.45 11:36:01 INFO - PROCESS | 21110 | Values: 383.6 383.8 392.2 394.6 398.7 12826.9 15501.8 15507.0 16366.3 16382.7 15825.8 15903.4 16213.3 17220.2 17409.4 4496.4 5035.2 5102.3 5207.3 5250.4 5023.0 5112.9 5124.3 5126.0 5141.9 5047.2 5123.8 5129.5 5129.9 5145.9 4973.8 5096.1 5102.9 5132.6 5143.3 4429.4 4604.8 4606.4 4606.6 4610.4 20272.3 20527.7 20616.5 20622.1 21021.9 2014.5 2077.5 2087.9 2281.2 2543.9 12812.4 12978.7 13007.1 13008.3 13661.0 1770.3 1800.3 1802.8 1803.5 1863.0 67403.7 69295.0 70053.0 70089.0 70211.0 9542.4 9754.8 9834.1 9977.3 10069.0 12059.1 12701.2 13704.0 13769.4 13893.2 6866.0 7032.2 7085.9 7239.9 7264.2 6544.9 6580.6 6742.6 6906.3 6938.2 6102.8 6124.4 6207.1 6246.9 6298.9 1803.1 1837.5 1850.4 1856.6 1884.8 826.4 892.4 959.0 983.3 1059.7 15847.3 16924.2 17330.0 17381.3 18128.5 877.7 880.4 892.1 928.9 951.3 9437.6 9572.2 9600.9 9638.9 9774.2 405176.0 423129.0 438794.0 441722.0 441943.0 79092.2 82129.6 82743.6 85331.6 88463.0 915.1 980.7 983.9 1003.3 1034.0 14639.0 15145.0 15291.4 15317.7 15565.2 24587.8 27000.6 30941.4 33089.0 34310.7 43458.6 43896.3 44338.3 45211.3 50028.0 7635.0 7700.4 7823.3 7950.3 7990.8 10911.0 12311.3 12363.3 12410.3 12447.0 10569.5 10584.9 10810.9 10814.6 10864.2 10244.8 10525.0 10610.4 10694.7 11114.2 10704.3 10839.8 10928.8 11000.4 11067.7 7803.3 7860.3 7887.9 7924.4 7955.4 9167.4 10685.5 10844.0 10867.7 10875.7 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | [#3] mootools.html Cycles:180 Average:5164.64 Median:5470.75 stddev:2810.22 (51.4%) stddev-sans-first:2804.18 11:36:01 INFO - PROCESS | 21110 | Values: 1442.1 1477.7 1612.5 1766.9 1789.7 6865.4 7501.1 7609.8 7745.4 7819.3 7561.8 7596.6 7626.0 7645.6 7658.1 2204.4 2244.7 2253.6 2259.6 2262.2 2186.7 2212.5 2220.7 2222.0 2224.0 2190.9 2198.4 2208.6 2222.0 2243.2 2126.9 2171.5 2178.2 2178.5 2178.8 2143.2 2144.6 2153.2 2153.8 2155.8 7767.6 7830.3 7849.5 7877.0 7917.0 4471.6 4642.3 4645.3 4660.1 4669.1 2851.4 2911.5 2971.5 2985.0 2987.7 926.0 963.4 983.3 989.5 993.7 10163.5 10322.2 10323.5 10334.0 10364.7 4153.1 4192.4 4280.7 4381.5 4402.1 8852.6 8897.6 8911.1 8955.1 8959.8 4728.3 4747.2 4757.4 4763.5 4784.7 3726.8 4167.2 4287.3 4298.8 4301.5 3607.4 3627.2 3722.3 3730.3 3736.1 1228.6 1241.0 1247.1 1258.3 1263.2 921.5 928.3 931.5 933.7 938.9 5378.1 5528.5 5544.7 5623.4 5728.5 910.9 925.8 928.1 931.7 962.3 3735.3 3852.5 3897.7 3922.0 3928.6 9339.4 9724.5 9727.8 9776.0 9801.6 9634.9 9708.9 9733.5 9747.8 9751.9 7262.2 7272.4 7300.3 7339.4 7356.9 5296.1 5371.8 5373.9 5407.5 5413.0 8752.6 8765.1 8808.9 8809.2 8879.9 8680.9 8864.9 9001.5 9074.1 9080.4 5754.3 6220.2 6223.2 6367.8 6449.1 7385.7 7413.0 7440.3 7450.4 7491.9 6356.9 6676.4 6695.9 6714.2 6769.4 6900.2 6902.4 6902.7 6981.7 6987.2 6405.6 6431.5 6449.8 6466.3 6477.4 4715.6 4746.2 4838.1 4852.5 4859.4 4811.5 4869.8 4899.0 4967.8 4986.0 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | [#4] prototype.html Cycles:180 Average:4636.69 Median:5325.89 stddev:1352.22 (25.4%) stddev-sans-first:1316.39 11:36:01 INFO - PROCESS | 21110 | Values: 307.5 313.6 315.1 315.6 318.8 5302.5 5334.5 5353.8 5371.6 5444.8 5293.9 5305.4 5324.6 5327.2 5327.2 3903.7 3922.9 4076.4 4083.6 4102.5 4106.1 4137.9 4138.3 4139.6 4148.4 4106.5 4109.9 4113.1 4114.4 4115.4 4035.3 4059.1 4106.9 4106.9 4111.7 3579.1 3595.3 3597.3 3598.7 3602.5 5050.8 5061.4 5063.2 5070.4 5104.3 4653.8 4746.4 4761.4 4778.8 4782.6 5557.6 5569.5 5586.1 5589.2 5613.0 3988.2 3995.7 4000.8 4003.6 4023.1 5688.2 5868.9 5881.8 5887.3 5891.4 4088.6 4091.4 4093.8 4096.1 4110.4 4152.4 4157.6 4173.2 4179.6 4180.6 4633.9 4737.5 4741.0 4741.1 4774.1 5625.5 5625.5 5637.6 5642.4 5689.2 1437.6 1465.5 1468.6 1469.3 1470.2 925.4 963.7 969.4 988.5 1005.3 4845.4 4849.7 4850.2 4869.6 4911.5 5700.4 5730.1 5754.9 5760.3 5761.5 4745.2 4823.7 4875.1 4904.3 4929.0 3079.3 3088.9 3089.7 3102.7 3116.1 5366.3 5371.7 5373.0 5375.7 5377.5 5732.8 5900.6 5919.5 5922.1 5922.6 5358.4 5361.5 5385.5 5387.5 5406.6 5531.4 5696.7 5725.4 5729.0 5745.4 5673.5 5683.5 5685.4 5686.8 5699.1 5392.8 5398.2 5414.3 5425.8 5456.5 3779.5 3954.5 3989.8 4135.9 4154.7 5820.2 5830.3 5837.8 5875.3 5877.1 5603.7 5619.7 5627.8 5633.5 5639.5 5486.7 5591.0 5643.5 5647.6 5665.7 5249.9 5536.6 5552.2 5553.4 5569.4 5494.8 5640.7 5681.6 5715.5 5727.9 5435.6 5447.0 5474.6 5482.2 5514.9 11:36:01 INFO - PROCESS | 21110 | 11:36:01 INFO - PROCESS | 21110 | [#5] yui.html Cycles:180 Average:12970.78 Median:42193.29 stddev:14660.32 (34.7%) stddev-sans-first:14672.32 11:36:01 INFO - PROCESS | 21110 | Values: 664.6 678.5 694.5 791.1 805.4 11663.4 12319.0 12632.0 12642.5 12653.9 13573.0 13605.6 13646.8 13699.5 13716.0 807.3 813.2 814.6 815.7 815.9 643.4 789.3 814.2 815.6 816.7 850.9 852.9 858.3 860.1 861.6 846.0 848.9 849.3 850.4 852.7 620.6 623.8 624.1 624.2 624.2 11926.6 12019.8 12038.6 12039.5 12040.9 12492.0 12695.7 12728.5 12731.5 12864.6 10235.6 10479.5 10509.4 10558.5 10934.8 3345.4 3373.2 3383.5 3400.4 3469.4 46903.5 47216.5 47301.8 47455.5 47831.3 9736.5 9949.2 9979.7 10000.2 10027.0 17298.1 17312.2 17324.6 17420.9 17474.7 6573.9 6612.6 6675.4 6681.7 6771.1 3815.4 3864.1 3905.8 3917.3 3941.6 2928.0 3041.2 3149.8 3312.6 3330.5 581.3 589.5 589.7 592.8 594.4 484.3 626.9 627.8 642.8 663.8 7674.8 7858.3 7884.5 8057.4 8058.2 610.8 615.9 626.4 628.8 630.3 3774.9 3827.8 3867.2 3908.6 3935.7 52129.7 52691.2 52708.7 52780.9 52793.2 47166.3 47410.3 47436.0 47860.0 48821.8 43574.8 43947.8 44356.8 44721.6 45085.3 7234.2 7248.7 7629.0 7651.1 7698.3 30194.1 30234.2 30281.8 30419.4 30606.1 33556.8 34288.3 36187.0 38977.0 40811.8 9951.0 10060.0 10085.8 10321.4 10516.6 11610.9 11714.9 11736.7 11892.0 12279.1 11343.3 11711.5 11918.3 11924.5 12012.1 11382.1 11868.6 11885.0 12043.5 12093.5 10696.8 10768.8 10773.1 10810.3 10981.8 9454.7 9780.7 9949.0 10013.9 10223.2 9488.2 9989.8 10061.5 10224.7 10318.7 11:36:01 INFO - PROCESS | 21110 | -------- Summary: end -------- 11:36:01 INFO - PROCESS | 21110 | 11:36:02 INFO - TEST-INFO | 21110: exit 0 11:36:02 INFO - TEST-OK | dromaeo_css | took 1116391ms 11:36:02 INFO - TEST-START | kraken 11:36:02 INFO - operating with platform_type : linux_ 11:36:02 INFO - Initialising browser for kraken test... 11:36:02 INFO - TEST-INFO | started process 21346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeY7TWI/profile http://localhost:47928/getInfo.html) 11:36:06 INFO - PROCESS | 21346 | 11:36:06 INFO - PROCESS | 21346 | (process:21415): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:36:07 INFO - PROCESS | 21346 | __metrics Screen width/height:1600/1200 11:36:07 INFO - PROCESS | 21346 | colorDepth:24 11:36:07 INFO - PROCESS | 21346 | Browser inner width/height: 1024/697 11:36:07 INFO - PROCESS | 21346 | __metrics 11:36:07 ERROR - PROCESS | 21346 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:36:08 INFO - TEST-INFO | 21346: exit 0 11:36:08 INFO - Browser initialized. 11:36:08 INFO - Running cycle 1/1 for kraken test... 11:36:08 INFO - TEST-INFO | started process 21466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeY7TWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:10 INFO - PROCESS | 21466 | 11:36:10 INFO - PROCESS | 21466 | (process:21526): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:36:20 INFO - PROCESS | 21466 | RSS: Main: 164962304 11:36:20 INFO - PROCESS | 21466 | 11:36:23 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47928/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:24 INFO - PROCESS | 21466 | RSS: Main: 169463808 11:36:24 INFO - PROCESS | 21466 | 11:36:27 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47928/tests/kraken/driver.html?testName=audio-dft) 11:36:27 INFO - PROCESS | 21466 | RSS: Main: 172830720 11:36:27 INFO - PROCESS | 21466 | 11:36:30 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47928/tests/kraken/driver.html?testName=audio-fft) 11:36:31 INFO - PROCESS | 21466 | RSS: Main: 164569088 11:36:31 INFO - PROCESS | 21466 | 11:36:33 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47928/tests/kraken/driver.html?testName=audio-oscillator) 11:36:34 INFO - PROCESS | 21466 | RSS: Main: 164298752 11:36:34 INFO - PROCESS | 21466 | 11:36:36 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:37 INFO - PROCESS | 21466 | RSS: Main: 164663296 11:36:37 INFO - PROCESS | 21466 | 11:36:40 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47928/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:40 INFO - PROCESS | 21466 | RSS: Main: 164974592 11:36:40 INFO - PROCESS | 21466 | 11:36:44 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47928/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:45 INFO - PROCESS | 21466 | RSS: Main: 164786176 11:36:45 INFO - PROCESS | 21466 | 11:36:47 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47928/tests/kraken/driver.html?testName=json-parse-financial) 11:36:48 INFO - PROCESS | 21466 | RSS: Main: 165310464 11:36:48 INFO - PROCESS | 21466 | 11:36:50 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:50 INFO - PROCESS | 21466 | RSS: Main: 165797888 11:36:50 INFO - PROCESS | 21466 | 11:36:52 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:53 INFO - PROCESS | 21466 | RSS: Main: 165912576 11:36:53 INFO - PROCESS | 21466 | 11:36:55 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:56 INFO - PROCESS | 21466 | RSS: Main: 165990400 11:36:56 INFO - PROCESS | 21466 | 11:36:59 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:59 INFO - PROCESS | 21466 | RSS: Main: 166273024 11:36:59 INFO - PROCESS | 21466 | 11:37:02 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:03 INFO - PROCESS | 21466 | RSS: Main: 166240256 11:37:03 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:47928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47928/tests/kraken/driver.html?testName=ai-astar) 11:37:05 INFO - PROCESS | 21466 | RSS: Main: 167575552 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | __start_tp_report 11:37:05 INFO - PROCESS | 21466 | _x_x_mozilla_page_load 11:37:05 INFO - PROCESS | 21466 | _x_x_mozilla_page_load_details 11:37:05 INFO - PROCESS | 21466 | |i|pagename|runs| 11:37:05 INFO - PROCESS | 21466 | |0;ai-astar;115;108;115;115;114;128;115;112;114;114 11:37:05 INFO - PROCESS | 21466 | |1;audio-beat-detection;171;135;159;193;134;161;158;133;189;135 11:37:05 INFO - PROCESS | 21466 | |2;audio-dft;164;163;168;167;169;163;162;162;166;163 11:37:05 INFO - PROCESS | 21466 | |3;audio-fft;73;74;74;167;80;76;72;73;162;78 11:37:05 INFO - PROCESS | 21466 | |4;audio-oscillator;95;95;141;95;95;94;136;96;93;139 11:37:05 INFO - PROCESS | 21466 | |5;imaging-gaussian-blur;117;117;118;118;118;117;119;118;117;118 11:37:05 INFO - PROCESS | 21466 | |6;imaging-darkroom;148;148;149;148;147;148;150;148;149;147 11:37:05 INFO - PROCESS | 21466 | |7;imaging-desaturate;95;95;95;96;96;94;95;96;96;96 11:37:05 INFO - PROCESS | 21466 | |8;json-parse-financial;65;65;64;64;66;65;65;83;64;62 11:37:05 INFO - PROCESS | 21466 | |9;json-stringify-tinderbox;66;66;66;66;65;65;65;65;67;66 11:37:05 INFO - PROCESS | 21466 | |10;stanford-crypto-aes;79;79;78;81;81;82;81;81;82;81 11:37:05 INFO - PROCESS | 21466 | |11;stanford-crypto-ccm;147;148;137;136;142;133;136;146;211;147 11:37:05 INFO - PROCESS | 21466 | |12;stanford-crypto-pbkdf2;174;174;178;171;183;173;181;174;178;171 11:37:05 INFO - PROCESS | 21466 | |13;stanford-crypto-sha256-iterative;74;74;71;71;73;76;70;75;71;73 11:37:05 INFO - PROCESS | 21466 | __end_tp_report 11:37:05 INFO - PROCESS | 21466 | __start_cc_report 11:37:05 INFO - PROCESS | 21466 | _x_x_mozilla_cycle_collect,926 11:37:05 INFO - PROCESS | 21466 | __end_cc_report 11:37:05 INFO - PROCESS | 21466 | __startTimestamp1461177425410__endTimestamp 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | ------- Summary: start ------- 11:37:05 INFO - PROCESS | 21466 | Number of tests: 14 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:5.06 (4.4%) stddev-sans-first:5.36 11:37:05 INFO - PROCESS | 21466 | Values: 115.0 108.0 115.0 115.0 114.0 128.0 115.0 112.0 114.0 114.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:160.00 stddev:22.63 (14.1%) stddev-sans-first:23.41 11:37:05 INFO - PROCESS | 21466 | Values: 171.0 135.0 159.0 193.0 134.0 161.0 158.0 133.0 189.0 135.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.73 11:37:05 INFO - PROCESS | 21466 | Values: 164.0 163.0 168.0 167.0 169.0 163.0 162.0 162.0 166.0 163.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#3] audio-fft Cycles:10 Average:92.90 Median:74.00 stddev:37.83 (51.1%) stddev-sans-first:39.44 11:37:05 INFO - PROCESS | 21466 | Values: 73.0 74.0 74.0 167.0 80.0 76.0 72.0 73.0 162.0 78.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.00 stddev:21.28 (22.4%) stddev-sans-first:22.05 11:37:05 INFO - PROCESS | 21466 | Values: 95.0 95.0 141.0 95.0 95.0 94.0 136.0 96.0 93.0 139.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:37:05 INFO - PROCESS | 21466 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 119.0 118.0 117.0 118.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 11:37:05 INFO - PROCESS | 21466 | Values: 148.0 148.0 149.0 148.0 147.0 148.0 150.0 148.0 149.0 147.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:37:05 INFO - PROCESS | 21466 | Values: 95.0 95.0 95.0 96.0 96.0 94.0 95.0 96.0 96.0 96.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.00 stddev:5.96 (9.2%) stddev-sans-first:6.31 11:37:05 INFO - PROCESS | 21466 | Values: 65.0 65.0 64.0 64.0 66.0 65.0 65.0 83.0 64.0 62.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:37:05 INFO - PROCESS | 21466 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 67.0 66.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:1.35 (1.7%) stddev-sans-first:1.32 11:37:05 INFO - PROCESS | 21466 | Values: 79.0 79.0 78.0 81.0 81.0 82.0 81.0 81.0 82.0 81.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:146.50 stddev:22.72 (15.5%) stddev-sans-first:24.09 11:37:05 INFO - PROCESS | 21466 | Values: 147.0 148.0 137.0 136.0 142.0 133.0 136.0 146.0 211.0 147.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.00 stddev:4.11 (2.3%) stddev-sans-first:4.31 11:37:05 INFO - PROCESS | 21466 | Values: 174.0 174.0 178.0 171.0 183.0 173.0 181.0 174.0 178.0 171.0 11:37:05 INFO - PROCESS | 21466 | 11:37:05 INFO - PROCESS | 21466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.50 stddev:1.99 (2.7%) stddev-sans-first:2.06 11:37:05 INFO - PROCESS | 21466 | Values: 74.0 74.0 71.0 71.0 73.0 76.0 70.0 75.0 71.0 73.0 11:37:05 INFO - PROCESS | 21466 | -------- Summary: end -------- 11:37:05 INFO - PROCESS | 21466 | 11:37:06 INFO - TEST-INFO | 21466: exit 0 11:37:06 INFO - TEST-OK | kraken | took 64247ms 11:37:06 INFO - SUITE-END | took 1180s 11:37:06 INFO - Completed test suite (00:19:40) 11:37:06 INFO - javascript benchmark 11:37:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.101240072175, 2662.986685066574, 2698.8245764025337, 2699.7030326664076, 2718.6601674790663, 4794.47260801312, 4813.061453016663, 4830.44449888263, 4841.055994081155, 4897.608191344692, 4751.928721069178, 4794.6404019698575, 4804.303376010476, 4807.735574543408, 4811.278308253755, 4317.28764753816, 4403.427554417921, 4440.555944405566, 4479.48485924118, 4537.591616754491, 4458.821647134111, 4486.214912390335, 4488.932666010012, 4496.9325460118125, 4532.388127602764, 4343.04453020335, 4452.621527170194, 4482.439695038121, 4497.797599108048, 4516.18708632446, 4421.314696222091, 4441.533638967894, 4448.377227188196, 4481.574250446202, 4491.079328737601, 4467.106578684276, 4480.955190448087, 4488.708233964782, 4501.482329532113, 4543.250363689987, 4685.2972054191805, 4697.0, 4735.644826637981, 4766.165920963817, 4822.590079843218, 5137.2037334213255, 5158.303629010074, 5167.7932882684645, 5191.221316802472, 5192.532672059495, 5023.095842748304, 5185.455527169631, 5190.351206099238, 5191.143461328877, 5202.06362854686, 4890.24201248807, 4915.557599815962, 4927.1131196384995, 4939.185034469308, 4964.280179374043, 5330.253764472977, 5336.893262134736, 5356.464353564613, 5381.273528073738, 5390.245365648812, 4929.556339929351, 5074.112030394666, 5089.8727531812, 5101.132807422747, 5136.332276803992, 5116.923246151311, 5143.022825663112, 5154.742262886841, 5157.432682404932, 5230.34620672416, 5096.439391666913, 5103.591712662978, 5110.821121260812, 5132.409772876093, 5145.691258524501, 4965.155923493015, 5055.09008378488, 5096.108181068298, 5096.286519887219, 5142.202958541432, 3857.517810273716, 3949.743266687656, 3960.1881614269005, 4009.077912080238, 4037.818298176589, 3510.2452972611013, 3529.8235088245483, 3592.9580421677942, 3607.494950706903, 3653.451982202691, 4529.954700452953, 4542.613877820422, 4554.339620754972, 4564.885877853014, 4595.333676616872, 5050.570701490415, 5142.228665700175, 5185.248139019896, 5241.030409374278, 5242.030224408497, 4482.238019536687, 4482.417285752831, 4495.056038232008, 4520.0, 4555.863324100216, 4520.4801447833925, 4629.305604159403, 4633.189191891473, 4644.535546445329, 4684.929726054112, 4882.389701287339, 4888.120138374984, 4922.064807686528, 4927.457979622311, 4949.678270912451, 5168.198929165986, 5210.426853046238, 5264.657797243167, 5264.815731449381, 5314.22943673173, 4784.234522476387, 4853.611711063036, 4899.706017638953, 4949.406071271471, 4959.181735013683, 5130.640855140105, 5143.3570803649545, 5144.897102058013, 5158.484151584811, 5206.088934436534, 5217.791288348575, 5228.790848366023, 5236.083685354972, 5241.528262456397, 5271.578273738015, 4881.365422495053, 4959.652824302264, 5005.1241032819835, 5070.797168113234, 5086.694798312114, 5011.123053465702, 5027.773750181177, 5030.0945829751, 5038.0, 5071.036503064406, 4915.361003069578, 4936.802527898843, 4938.703677779345, 4953.975230123826, 4993.975030124826, 4907.607391408607, 5053.26727624485, 5106.770195341144, 5113.105206588758, 5146.176611742103, 4816.638752093537, 4974.403071631427, 5041.42023667283, 5055.292259083658, 5103.923441148311], "value": 4730.614877167067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5511818104607, 605.8818530386575, 609.5854818723269, 626.3767551286471, 638.5179189711766, 36018.639813601854, 37442.43836342457, 37505.24989500208, 37571.81214093933, 37650.0, 38698.226035479274, 39134.608653913456, 39226.607733922654, 39252.21495570087, 39263.21473570534, 7574.848503029936, 7791.0, 7825.6087195640275, 7830.843383132334, 7833.451658383916, 7641.579713115776, 7695.115061767884, 7725.72959946402, 7741.148473667892, 7755.767326980172, 7757.107932587768, 7824.5696486693205, 7842.254985776371, 7866.606669666522, 7886.32966197871, 7718.266764657348, 7773.378129749634, 7813.648385822623, 7841.098273698541, 7841.372690184771, 7732.768016959444, 7836.412269079842, 7838.059432868093, 7838.372930165573, 7856.489328193649, 29083.709162908523, 36211.0, 36606.816965915, 36691.266174676624, 36717.26565468676, 3090.103869877733, 3125.937481250385, 3235.919102022445, 3259.820709860957, 3274.9345013099605, 23818.0, 24141.517169656683, 24160.0, 24662.13682521121, 25007.62488562673, 3237.2806842252385, 3312.7018568328967, 3346.0965539304493, 3391.5251864738957, 3401.897943061712, 184960.0, 185380.0, 185836.0, 186079.0, 186464.0, 32100.197495062344, 32288.515672264934, 32332.676673233436, 32900.67099329024, 34018.48972265418, 32030.359392812014, 32041.839790800896, 32068.358632827214, 32087.839560802513, 32213.838930805196, 12277.324747138815, 12368.567100151631, 12462.937685311515, 12463.0, 12529.122961392615, 10082.49587520621, 10123.1901447884, 10129.189664826796, 10161.949190254149, 10171.28800983924, 8133.59332033396, 8135.430519863553, 8159.184081591912, 8206.958965205136, 8234.135415781377, 3173.4763763979145, 3207.9839600801847, 3216.9195770105466, 3236.417444859948, 3289.5394644749276, 939.9624015039321, 954.3510412919143, 977.3793641037992, 1003.0370843989706, 1102.9944850275697, 28358.0, 28560.42879142447, 28739.27564346146, 28958.85520572426, 29198.416031679248, 1047.1518070363031, 1067.7384040910026, 1075.7095584192225, 1111.2054880760295, 1154.3362566524281, 14882.181480018486, 15148.0, 15150.54548363551, 15513.146776927377, 15560.688786224213, 344561.0, 414613.0, 433220.0, 433985.0, 433990.0, 49021.0, 50232.74883625558, 50277.74861125671, 50288.748556256985, 50430.0, 1170.4206417823232, 1277.8786015328528, 1281.2312612432652, 1283.8651941546377, 1287.6523338698687, 27390.315242119108, 28692.282692932844, 29193.85403072971, 29287.853560732914, 29487.0, 42557.5744242566, 43471.0, 43607.34588981231, 43631.0, 43633.781831090644, 318821.0, 318877.0, 320564.0, 321105.0, 321923.0, 25203.873980629978, 25940.8702956484, 25978.220653380427, 25982.0, 38165.4275185878, 36365.63634363622, 36748.44877326896, 37092.443613345284, 37264.06839829026, 37629.247415052094, 34224.0, 34805.47791783176, 34993.0, 35810.28379432449, 35928.101797455274, 33673.15817104592, 34416.48375274423, 34613.13467163341, 34630.0, 34701.47947780836, 31389.372212556078, 35157.0, 37846.43230351602, 38935.22129557336, 40913.1817363657, 30658.080257592308, 31575.21061973469, 31843.84078079595, 32079.0, 32294.677053230105, 24152.154674586305, 25225.11712090068, 25236.24291271265, 25783.484330312913, 25803.870980644977], "value": 16098.607213329655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6182997917072, 383.83878770916215, 392.1725159912584, 394.58174335204683, 398.7169109931948, 12826.935865320684, 15501.844981550195, 15507.0, 16366.345346186139, 16382.672346553076, 15825.762613560777, 15903.363865445397, 16213.270402831871, 17220.225089870954, 17409.390671326506, 4496.415465989417, 5035.219540971137, 5102.336696229485, 5207.270982062514, 5250.396204436482, 5022.974885125569, 5112.872178195537, 5124.282600435942, 5126.026055049529, 5141.948580514203, 5047.2176812593925, 5123.769430375623, 5129.53834154926, 5129.948700512984, 5145.897082058356, 4973.801047958095, 5096.133657278272, 5102.948970510303, 5132.615053870974, 5143.254228136918, 4429.446319210098, 4604.769761511911, 4606.447226332828, 4606.585407313358, 4610.446746390421, 20272.290469833486, 20527.692084618742, 20616.484587885272, 20622.072006759732, 21021.89489052545, 2014.5165160361555, 2077.542940553076, 2087.9478013049643, 2281.178775640768, 2543.885525151373, 12812.359382030954, 12978.675533111653, 13007.089503734742, 13008.349582520836, 13661.043726939119, 1770.3272756352633, 1800.2528950485532, 1802.8467580255694, 1803.4589623113013, 1863.0032932381246, 67403.66298168527, 69295.0, 70053.0, 70088.99999999949, 70211.0, 9542.42745435276, 9754.804903901882, 9834.114929656365, 9977.25170612207, 10069.007378366447, 12059.095567832448, 12701.174423662433, 13704.0, 13769.449222031006, 13893.235872027135, 6866.0, 7032.156141263081, 7085.89371159433, 7239.855202895913, 7264.237255088246, 6544.934550654528, 6580.63806490638, 6742.6291553965, 6906.309369063053, 6938.236793952661, 6102.816915492543, 6124.418180272956, 6207.099970504251, 6246.937530624636, 6298.874022519615, 1803.107461806388, 1837.503873954025, 1850.3893715073993, 1856.5822689894665, 1884.7738271407245, 826.4173757501068, 892.4377642085444, 958.9664361747306, 983.3460748602099, 1059.7350662334416, 15847.286872090783, 16924.238409271366, 17330.0, 17381.32311254858, 18128.546786330182, 877.7015814623059, 880.3573391424168, 892.054422312351, 928.9117533834275, 951.3103000324847, 9437.575309111107, 9572.186364159124, 9600.855987160197, 9638.855417168748, 9774.218062554979, 405176.0, 423129.0, 438794.0, 441722.0, 441943.0, 79092.20907790848, 82129.58935205286, 82743.5862820694, 85331.57334213289, 88463.0, 915.1260546178383, 980.6567701304486, 983.8524221366853, 1003.3327836988467, 1033.9711986573407, 14639.0, 15145.015573987655, 15291.388344466097, 15317.693646126792, 15565.221738912782, 24587.75412245926, 27000.594991074755, 30941.381172375975, 33089.0, 34310.65689343175, 43458.56541434672, 43896.34155487734, 44338.334924975505, 45211.32183017192, 50028.0, 7634.961825190839, 7700.422468314787, 7823.335016523659, 7950.284474397332, 7990.760277191694, 10911.049707223146, 12311.322877241837, 12363.32001739913, 12410.255384676948, 12447.0, 10569.471526423802, 10584.8941510587, 10810.945945270223, 10814.56741730322, 10864.172884486003, 10244.795104097728, 10525.0, 10610.416427096583, 10694.73263168427, 11114.166437517057, 10704.30422022566, 10839.837402439127, 10928.781424371628, 11000.394978276272, 11067.72773787171, 7803.297703206738, 7860.3318717909615, 7887.921120788718, 7924.4056695746895, 7955.443118981616, 9167.358284919992, 10685.465726713477, 10844.0, 10867.673969780919, 10875.673729788119], "value": 8363.987337038903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.077070674768, 1477.6675248069182, 1612.5243053299275, 1766.929322827087, 1789.686804809158, 6865.382115609594, 7501.137369202544, 7609.771706848804, 7745.380369570435, 7819.2571705688015, 7561.848763024736, 7596.582187979673, 7626.046744156981, 7645.579493127876, 7658.119316278629, 2204.4378683435743, 2244.708187935566, 2253.6281513550325, 2259.5819773341987, 2262.2082271205027, 2186.693862859201, 2212.524307273936, 2220.711307530019, 2222.022310183514, 2223.966640500386, 2190.8904554772275, 2198.4064302638276, 2208.624533829253, 2222.0, 2243.170027089971, 2126.9361919142452, 2171.4679903423685, 2178.1505212966954, 2178.4662757624405, 2178.8365872559543, 2143.228437762404, 2144.613969485492, 2153.1710291537715, 2153.752318483379, 2155.8490905636613, 7767.572783496906, 7830.334421574116, 7849.4897831640765, 7876.960615196887, 7916.960415197887, 4471.575200355994, 4642.257238841803, 4645.303204519315, 4660.091282199973, 4669.089527542131, 2851.4154598307505, 2911.5195992661183, 2971.450281697871, 2985.000024991609, 2987.656419511762, 926.0, 963.3834346018554, 983.2920297385871, 989.5101924547395, 993.7366597851575, 10163.4918254087, 10322.174226061898, 10323.535440905178, 10334.0, 10364.740881477948, 4153.1070819773895, 4192.434021407071, 4280.657547396201, 4381.474223093249, 4402.053558484941, 8852.557372131369, 8897.599608017656, 8911.108889111038, 8955.05971872957, 8959.776005599912, 4728.267118596623, 4747.216709242936, 4757.381540399795, 4763.476017638057, 4784.6889952153, 3726.8136593170234, 4167.2082304362075, 4287.3140297552245, 4298.806553705091, 4301.548337424588, 3607.4408466687705, 3627.220147668264, 3722.3299806034634, 3730.291244663505, 3736.1220113273357, 1228.6498347970785, 1241.0, 1247.089624574066, 1258.2513404524293, 1263.2294300476701, 921.5162039928957, 928.3037721708719, 931.5063016601213, 933.7338858425452, 938.9295802814817, 5378.112611419072, 5528.474794894559, 5544.667319960815, 5623.381428042912, 5728.455796699307, 910.9453432794054, 925.8379783537854, 928.1229238369676, 931.6785708930408, 962.2879069488528, 3735.327641024587, 3852.4799152114665, 3897.707671924617, 3921.9607803922167, 3928.607139286106, 9339.392939458914, 9724.465154416575, 9727.805443891082, 9776.0, 9801.607935682492, 9634.90365096354, 9708.883478399934, 9733.464659443798, 9747.756306092262, 9751.902480975099, 7262.20115787263, 7272.3818475429125, 7300.269973002657, 7339.449541284425, 7356.926430735732, 5296.099663057213, 5371.838844834661, 5373.946260537501, 5407.53996420972, 5413.025655382069, 8752.64989400417, 8765.07966663491, 8808.91191088081, 8809.163129502687, 8879.911200888168, 8680.869786953326, 8864.911350886408, 9001.459912405277, 9074.092590740873, 9080.364374493722, 5754.309482861916, 6220.160278362544, 6223.190985171898, 6367.808965731036, 6449.129367535323, 7385.741499047507, 7413.0, 7440.2931721486375, 7450.403967682681, 7491.8501629966, 6356.936430635819, 6676.399124078856, 6695.933040669531, 6714.227863795726, 6769.3907548320885, 6900.2409734930125, 6902.378785909293, 6902.689378978059, 6981.650917454005, 6987.196472405535, 6405.615663060231, 6431.48548116159, 6449.774257900951, 6466.321036291121, 6477.4170324671, 4715.599174070242, 4746.1694203514935, 4838.104950584153, 4852.539008794159, 4859.416869975485, 4811.542903424169, 4869.756512174306, 4898.9957058803575, 4967.82612608557, 4985.9501404985485], "value": 4213.612068094541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.4880324260107, 313.61268832991254, 315.0941044497072, 315.5597940872482, 318.7927846899515, 5302.522772950439, 5334.546563542094, 5353.785848566057, 5371.57027437805, 5444.8366549003595, 5293.947060529394, 5305.389880163782, 5324.5740340772745, 5327.200919862023, 5327.227552004967, 3903.687704983609, 3922.882313530599, 4076.449679293302, 4083.612056854594, 4102.548719640837, 4106.137711080677, 4137.8965525861795, 4138.33786594145, 4139.606737359961, 4148.439960605325, 4106.486689163855, 4109.876703698894, 4113.095119073799, 4114.444549985744, 4115.42384066231, 4035.315243415811, 4059.0867054912705, 4106.876793696164, 4106.876793696194, 4111.691623128248, 3579.0873327301633, 3595.334863050344, 3597.3344931187553, 3598.6941110005682, 3602.5316708827945, 5050.823221187241, 5061.392632884077, 5063.215201643714, 5070.366204224472, 5104.259882317043, 4653.790579423934, 4746.382970213885, 4761.40482439695, 4778.784954677048, 4782.641301902337, 5557.555395568385, 5569.526590239834, 5586.078297080977, 5589.245451863987, 5613.0, 3988.202359528106, 3995.680345572347, 4000.7799571023584, 4003.599640035973, 4023.094803669151, 5688.175214593902, 5868.853278668067, 5881.764729410861, 5887.293524777011, 5891.3814049525035, 4088.6490268095963, 4091.4476545665952, 4093.7748423836974, 4096.139810639799, 4110.403991421227, 4152.44624555902, 4157.605027522381, 4173.1862286853775, 4179.6029377209115, 4180.602842729936, 4633.86098417048, 4737.478877323491, 4741.004389078264, 4741.122892264942, 4774.116788394089, 5625.46558076982, 5625.493705566519, 5637.605367624309, 5642.407547207484, 5689.175069614883, 1437.5687293811814, 1465.5090544667441, 1468.6255004973877, 1469.2653673163418, 1470.2354775516671, 925.3707478914403, 963.6675347005272, 969.3699095587924, 988.5452691761726, 1005.2812239248972, 4845.442774080955, 4849.733264670477, 4850.223964165716, 4869.586085182728, 4911.45973942866, 5700.429957004267, 5730.1404789281105, 5754.942450575524, 5760.251167348218, 5761.48146666802, 4745.240761478216, 4823.686460380064, 4875.146849301358, 4904.2643603459765, 4928.950710492849, 3079.3071558899514, 3088.9382212355627, 3089.6910308969373, 3102.674219206996, 3116.0807561769334, 5366.329208848894, 5371.650842695212, 5373.0, 5375.6774593524515, 5377.5160235578205, 5732.77068917247, 5900.64596124234, 5919.496842768327, 5922.082077278029, 5922.608187076034, 5358.3837858645975, 5361.544268737123, 5385.461453854583, 5387.515123638891, 5406.621536492407, 5531.446855314436, 5696.658200507983, 5725.398833122629, 5729.0, 5745.368009518866, 5673.517750991212, 5683.5100270785615, 5685.431456854281, 5686.829395118153, 5699.116636921284, 5392.757325920422, 5398.1902714593125, 5414.3232095988005, 5425.83722488326, 5456.454354564512, 3779.4708740776864, 3954.4661470701085, 3989.8404063838284, 4135.937960930528, 4154.667626589926, 5820.214271073351, 5830.338353569213, 5837.795677151279, 5875.294964604275, 5877.089051197071, 5603.74783134768, 5619.747111379916, 5627.774889004394, 5633.492985631149, 5639.520640745583, 5486.698231597141, 5591.04952158126, 5643.492085712305, 5647.604667673223, 5665.66006039639, 5249.921251181312, 5536.557075434036, 5552.194931734956, 5553.444655534414, 5569.443055694398, 5494.835154945358, 5640.661560306395, 5681.602287839812, 5715.485606295453, 5727.914081288867, 5435.646682965595, 5447.0, 5474.644148130359, 5482.205080263259, 5514.862128446821], "value": 4205.351625673339, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.6211659354167, 678.5080816408104, 694.4513834071084, 791.0823444804025, 805.4321703199245, 11663.41682915855, 12319.0, 12631.989440844722, 12642.494300228003, 12653.936730316336, 13573.0, 13605.591832245023, 13646.795298070538, 13699.520516781915, 13716.0, 807.2573232625969, 813.2233716800441, 814.5560669435172, 815.6533473273864, 815.9306458950966, 643.3694978920661, 789.3369569561568, 814.1898810683349, 815.5636734347125, 816.6814942172557, 850.8766228896807, 852.9189726975927, 858.2618947704968, 860.0539406652695, 861.6165806216205, 845.9915400845974, 848.9278411335013, 849.2611428057568, 850.3877208409934, 852.6845067325129, 620.6245221640933, 623.8128561431598, 624.0981781325986, 624.1636207481996, 624.1854380034054, 11926.582569610022, 12019.819702704466, 12038.638840834788, 12039.518419263219, 12040.939795301056, 12492.0, 12695.74608507834, 12728.490860365575, 12731.490740370375, 12864.620045291558, 10235.6417525387, 10479.476026198736, 10509.421981790998, 10558.52486638103, 10934.781304373948, 3345.381104495676, 3373.2241584435474, 3383.4924761285756, 3400.404929137416, 3469.3755124077657, 46903.53096469026, 47216.52783472156, 47301.763491182326, 47455.52544474546, 47831.282530762066, 9736.513174341255, 9949.154321882575, 9979.650712225037, 10000.199984001263, 10027.04743049409, 17298.135093245288, 17312.22095005728, 17324.566885827702, 17420.912895435442, 17474.65050698979, 6573.934260657428, 6612.570182938093, 6675.432588229958, 6681.699323530453, 6771.052052712625, 3815.4467602197524, 3864.072622570563, 3905.7851818150275, 3917.2948869203815, 3941.5664276929515, 2927.9707202928125, 3041.163679988021, 3149.7715890802606, 3312.585926759155, 3330.500424936279, 581.340178896955, 589.4989259129705, 589.7375667827775, 592.8043745563954, 594.3610618585038, 484.295350265363, 626.8871603111393, 627.8399008252866, 642.7975187815823, 663.7577284291199, 7674.769756907302, 7858.292753652198, 7884.526928384201, 8057.395695322874, 8058.194180582012, 610.8472881779555, 615.9168512250878, 626.3579830673505, 628.8490762217035, 630.2972186012563, 3774.8678796241998, 3827.8468861245797, 3867.207222519377, 3908.6286802753693, 3935.7244992850224, 52129.739351303004, 52691.209631855556, 52708.73645631824, 52780.94438111216, 52793.2081018785, 47166.292505612444, 47410.28884566734, 47436.0, 47860.0, 48821.75589122032, 43574.7821260898, 43947.78026109849, 44356.778216108716, 44721.55278447239, 45085.323720144224, 7234.240404757425, 7248.710051597877, 7628.961855190689, 7651.120121186135, 7698.2686644768655, 30194.09417717472, 30234.24414389658, 30281.848590756905, 30419.39161216719, 30606.08181754551, 33556.83221583877, 34288.314233714686, 36187.0, 38977.0, 40811.79594102011, 9951.0, 10060.0, 10085.848712269175, 10321.432321222404, 10516.57933682644, 11610.88389116098, 11714.88285117172, 11736.650285217309, 11892.0, 12279.140460167702, 11343.319400835977, 11711.531538738354, 11918.344491053076, 11924.463399146885, 12012.089382153366, 11382.089432845187, 11868.643940681794, 11885.049196064467, 12043.518259269882, 12093.516259349528, 10696.83954740664, 10768.784624307627, 10773.138148948223, 10810.29733067348, 10981.835272471078, 9454.669086582211, 9780.657676981271, 9948.950255248967, 10013.949930250303, 10223.182145428496, 9488.193503552275, 9989.800203995734, 10061.496925153859, 10224.744381390525, 10318.742031449274], "value": 6060.863867284368, "unit": "score"}], "name": "dromaeo_css", "value": 6395.266536779917, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 115.0, 115.0, 114.0, 128.0, 115.0, 112.0, 114.0, 114.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 135.0, 159.0, 193.0, 134.0, 161.0, 158.0, 133.0, 189.0, 135.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 168.0, 167.0, 169.0, 163.0, 162.0, 162.0, 166.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 167.0, 80.0, 76.0, 72.0, 73.0, 162.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 141.0, 95.0, 95.0, 94.0, 136.0, 96.0, 93.0, 139.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 150.0, 148.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 83.0, 64.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 67.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 81.0, 81.0, 82.0, 81.0, 81.0, 82.0, 81.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 137.0, 136.0, 142.0, 133.0, 136.0, 146.0, 211.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 178.0, 171.0, 183.0, 173.0, 181.0, 174.0, 178.0, 171.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 71.0, 71.0, 73.0, 76.0, 70.0, 75.0, 71.0, 73.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1607.9, "alertThreshold": 2.0}]} 11:37:06 INFO - Return code: 0 11:37:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:37:06 ERROR - # TBPL SUCCESS # 11:37:06 INFO - Running post-action listener: _resource_record_post_action 11:37:06 INFO - Running post-run listener: _resource_record_post_run 11:37:07 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530755584; Read time: 12; Write time: 588644 11:37:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 184496128; Read time: 0; Write time: 348768 11:37:07 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296333312; Read time: 12; Write time: 222296 11:37:07 INFO - Running post-run listener: _upload_blobber_files 11:37:07 INFO - Blob upload gear active. 11:37:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:07 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 11:37:07 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'] 11:37:07 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 11:37:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:09 INFO - (blobuploader) - INFO - Done attempting. 11:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:09 INFO - (blobuploader) - INFO - Done attempting. 11:37:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:09 INFO - Return code: 0 11:37:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28993418eb4316c74a8984bef9936c306a565830ed19d698c8a23429e65a1f7fb56dc35c8489d749f2200079c58a5ffade98c9275a925ac439f3da3866a44d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71808e6c62dc01ee95847ec2216c84df548f56409769bacb5aab8680e77c92ffa62f7fccfd3dc01e712456e88585f3190950308fe0e6b338c5a4a4f719ffa5e2"} 11:37:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:09 INFO - Contents: 11:37:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28993418eb4316c74a8984bef9936c306a565830ed19d698c8a23429e65a1f7fb56dc35c8489d749f2200079c58a5ffade98c9275a925ac439f3da3866a44d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71808e6c62dc01ee95847ec2216c84df548f56409769bacb5aab8680e77c92ffa62f7fccfd3dc01e712456e88585f3190950308fe0e6b338c5a4a4f719ffa5e2"} 11:37:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:09 INFO - Copying logs to upload dir... 11:37:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.790038 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-20 11:37:09.054782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 11:37:09.058625) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28993418eb4316c74a8984bef9936c306a565830ed19d698c8a23429e65a1f7fb56dc35c8489d749f2200079c58a5ffade98c9275a925ac439f3da3866a44d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71808e6c62dc01ee95847ec2216c84df548f56409769bacb5aab8680e77c92ffa62f7fccfd3dc01e712456e88585f3190950308fe0e6b338c5a4a4f719ffa5e2"} build_url:https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/H7Y_dYS7SI6rP7gyVZMYNA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28993418eb4316c74a8984bef9936c306a565830ed19d698c8a23429e65a1f7fb56dc35c8489d749f2200079c58a5ffade98c9275a925ac439f3da3866a44d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71808e6c62dc01ee95847ec2216c84df548f56409769bacb5aab8680e77c92ffa62f7fccfd3dc01e712456e88585f3190950308fe0e6b338c5a4a4f719ffa5e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 11:37:09.083694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 11:37:09.084026) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461175120.569180-765215487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 11:37:09.167063) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 11:37:09.167404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 11:37:09.167730) ========= ========= Total master_lag: 0.19 =========