builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1461527261.18 results: success (0) buildid: 20160424114349 builduid: bceebdefc9044d429d2b6806c3bb2160 revision: a07ea7fb572f503761e11fdae02f6d0340f157ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.175455) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.175862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.176123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.198558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.198849) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 12:47:43-- 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% 223M=0s 2016-04-24 12:47:43 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.328341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.328616) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.379214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.379540) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a07ea7fb572f503761e11fdae02f6d0340f157ec --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 a07ea7fb572f503761e11fdae02f6d0340f157ec --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=74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 12:47:44,114 truncating revision to first 12 chars 2016-04-24 12:47:44,114 Setting DEBUG logging. 2016-04-24 12:47:44,114 attempt 1/10 2016-04-24 12:47:44,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a07ea7fb572f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 12:47:44,357 unpacking tar archive at: fx-team-a07ea7fb572f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.913790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.914104) ========= script_repo_revision: a07ea7fb572f503761e11fdae02f6d0340f157ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.914490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.914786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 12:47:41.924647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-24 12:47:41.925083) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:47:44 INFO - MultiFileLogger online at 20160424 12:47:44 in /builds/slave/test 12:47:44 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 12:47:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:47:44 INFO - {'append_to_log': False, 12:47:44 INFO - 'base_work_dir': '/builds/slave/test', 12:47:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:47:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:47:44 INFO - 'branch': 'Fx-Team-Non-PGO', 12:47:44 INFO - 'buildbot_json_path': 'buildprops.json', 12:47:44 INFO - 'config_files': ('talos/linux_config.py',), 12:47:44 INFO - 'default_actions': ('clobber', 12:47:44 INFO - 'read-buildbot-config', 12:47:44 INFO - 'download-and-extract', 12:47:44 INFO - 'populate-webroot', 12:47:44 INFO - 'create-virtualenv', 12:47:44 INFO - 'install', 12:47:44 INFO - 'run-tests'), 12:47:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:47:44 INFO - 'download_minidump_stackwalk': True, 12:47:44 INFO - 'download_symbols': 'ondemand', 12:47:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:47:44 INFO - 'tooltool.py': '/tools/tooltool.py', 12:47:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:47:44 INFO - '/tools/misc-python/virtualenv.py')}, 12:47:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:47:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:47:44 INFO - 'installer_path': 'installer.exe', 12:47:44 INFO - 'log_level': 'info', 12:47:44 INFO - 'log_name': 'talos', 12:47:44 INFO - 'log_to_console': True, 12:47:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:47:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:47:44 INFO - 'opt_config_files': (), 12:47:44 INFO - 'pip_index': False, 12:47:44 INFO - 'sps_profile': False, 12:47:44 INFO - 'sps_profile_interval': 0, 12:47:44 INFO - 'suite': 'dromaeojs-e10s', 12:47:44 INFO - 'system_bits': '32', 12:47:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:47:44 INFO - 'title': 'talos-linux64-ix-042', 12:47:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:47:44 INFO - 'use_talos_json': True, 12:47:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:47:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:47:44 INFO - 'work_dir': 'build'} 12:47:44 INFO - ##### 12:47:44 INFO - ##### Running clobber step. 12:47:44 INFO - ##### 12:47:44 INFO - Running pre-action listener: _resource_record_pre_action 12:47:44 INFO - Running main action method: clobber 12:47:44 INFO - rmtree: /builds/slave/test/build 12:47:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:47:45 INFO - Running post-action listener: _resource_record_post_action 12:47:45 INFO - ##### 12:47:45 INFO - ##### Running read-buildbot-config step. 12:47:45 INFO - ##### 12:47:45 INFO - Running pre-action listener: _resource_record_pre_action 12:47:45 INFO - Running main action method: read_buildbot_config 12:47:45 INFO - Using buildbot properties: 12:47:45 INFO - { 12:47:45 INFO - "project": "", 12:47:45 INFO - "product": "firefox", 12:47:45 INFO - "script_repo_revision": "production", 12:47:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:47:45 INFO - "repository": "", 12:47:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:47:45 INFO - "buildid": "20160424114349", 12:47:45 INFO - "pgo_build": "False", 12:47:45 INFO - "basedir": "/builds/slave/test", 12:47:45 INFO - "buildnumber": 1440, 12:47:45 INFO - "slavename": "talos-linux64-ix-042", 12:47:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:47:45 INFO - "platform": "ubuntu64_hw", 12:47:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:47:45 INFO - "branch": "fx-team", 12:47:45 INFO - "repo_path": "integration/fx-team", 12:47:45 INFO - "revision": "a07ea7fb572f503761e11fdae02f6d0340f157ec", 12:47:45 INFO - "stage_platform": "linux64", 12:47:45 INFO - "builduid": "bceebdefc9044d429d2b6806c3bb2160", 12:47:45 INFO - "slavebuilddir": "test" 12:47:45 INFO - } 12:47:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:47:45 INFO - Running post-action listener: _resource_record_post_action 12:47:45 INFO - ##### 12:47:45 INFO - ##### Running download-and-extract step. 12:47:45 INFO - ##### 12:47:45 INFO - Running pre-action listener: _resource_record_pre_action 12:47:45 INFO - Running main action method: download_and_extract 12:47:45 INFO - mkdir: /builds/slave/test/build/tests 12:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:45 INFO - https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:47:57 INFO - Downloaded 1361 bytes. 12:47:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:47:57 INFO - Using the following test package requirements: 12:47:57 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:47:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:47:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:47:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'jsshell-linux-x86_64.zip'], 12:47:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:47:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:47:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:47:57 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:47:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:47:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:47:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:47:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:47:57 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')]} 12:47:57 INFO - https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:04 INFO - Downloaded 22285608 bytes. 12:48:04 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'] 12:48:04 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 12:48:06 INFO - Return code: 0 12:48:06 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 12:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:06 INFO - https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:07 INFO - Downloaded 22285608 bytes. 12:48:07 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'] 12:48:07 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 12:48:08 INFO - Return code: 0 12:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:08 INFO - https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:09 INFO - Downloaded 10840145 bytes. 12:48:09 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'] 12:48:09 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 12:48:09 INFO - Return code: 0 12:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:09 INFO - https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GpMZjFiGTNye4LNz6vzmQg/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 12:48:11 INFO - Downloaded 54733773 bytes. 12:48:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:48:11 INFO - mkdir: /builds/slave/test/properties 12:48:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:11 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:11 INFO - Contents: 12:48:11 INFO - build_url:https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:48:12 INFO - Running post-action listener: _resource_record_post_action 12:48:12 INFO - Running post-action listener: set_extra_try_arguments 12:48:12 INFO - ##### 12:48:12 INFO - ##### Running populate-webroot step. 12:48:12 INFO - ##### 12:48:12 INFO - Running pre-action listener: _resource_record_pre_action 12:48:12 INFO - Running main action method: populate_webroot 12:48:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:12 INFO - '--tppagecycles', 12:48:12 INFO - '7'], 12:48:12 INFO - 'tests': ['tsvgm']}}, 12:48:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:48:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:48:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['damp', 'tps']}, 12:48:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'tests': ['damp', 'tps']}, 12:48:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['dromaeo_dom']}, 12:48:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['a11yr', 12:48:12 INFO - 'ts_paint', 12:48:12 INFO - 'tpaint', 12:48:12 INFO - 'sessionrestore', 12:48:12 INFO - 'sessionrestore_no_auto_restore', 12:48:12 INFO - 'tabpaint']}, 12:48:12 INFO - 'other-e10s': {'tests': ['a11yr', 12:48:12 INFO - 'ts_paint', 12:48:12 INFO - 'tpaint', 12:48:12 INFO - 'sessionrestore', 12:48:12 INFO - 'sessionrestore_no_auto_restore', 12:48:12 INFO - 'tabpaint']}, 12:48:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:48:12 INFO - 'ts_paint', 12:48:12 INFO - 'tpaint', 12:48:12 INFO - 'sessionrestore', 12:48:12 INFO - 'sessionrestore_no_auto_restore', 12:48:12 INFO - 'tabpaint']}, 12:48:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:48:12 INFO - 'ts_paint', 12:48:12 INFO - 'tpaint', 12:48:12 INFO - 'sessionrestore', 12:48:12 INFO - 'sessionrestore_no_auto_restore', 12:48:12 INFO - 'tabpaint']}, 12:48:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['a11yr', 12:48:12 INFO - 'ts_paint', 12:48:12 INFO - 'tpaint', 12:48:12 INFO - 'sessionrestore', 12:48:12 INFO - 'sessionrestore_no_auto_restore', 12:48:12 INFO - 'tabpaint']}, 12:48:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['a11yr', 12:48:12 INFO - 'ts_paint', 12:48:12 INFO - 'tpaint', 12:48:12 INFO - 'sessionrestore', 12:48:12 INFO - 'sessionrestore_no_auto_restore', 12:48:12 INFO - 'tabpaint']}, 12:48:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['tsvgx', 12:48:12 INFO - 'tsvgr_opacity', 12:48:12 INFO - 'tart', 12:48:12 INFO - 'tscrollx', 12:48:12 INFO - 'cart']}, 12:48:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:48:12 INFO - 'tsvgr_opacity', 12:48:12 INFO - 'tart', 12:48:12 INFO - 'tscrollx', 12:48:12 INFO - 'cart']}, 12:48:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'talos_options': ['--disable-e10s'], 12:48:12 INFO - 'tests': ['tp5o']}, 12:48:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'tests': ['tp5o']}, 12:48:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'talos_options': ['--disable-e10s', 12:48:12 INFO - '--xperf_path', 12:48:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:12 INFO - 'tests': ['tp5n']}, 12:48:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:12 INFO - 'talos_options': ['--xperf_path', 12:48:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:12 INFO - 'tests': ['tp5n']}}, 12:48:12 INFO - 'talos.zip': {'path': '', 12:48:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:12 INFO - Running post-action listener: _resource_record_post_action 12:48:12 INFO - ##### 12:48:12 INFO - ##### Running create-virtualenv step. 12:48:12 INFO - ##### 12:48:12 INFO - Running pre-action listener: _resource_record_pre_action 12:48:12 INFO - Running main action method: create_virtualenv 12:48:12 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:12 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 12:48:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:12 INFO - Using real prefix '/usr' 12:48:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:13 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:15 INFO - Installing pip.................done. 12:48:15 INFO - Return code: 0 12:48:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:15 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 12:48:15 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 12:48:15 INFO - Using env: {'DISPLAY': ':0', 12:48:15 INFO - 'HOME': '/home/cltbld', 12:48:15 INFO - 'LANG': 'en_US.UTF-8', 12:48:15 INFO - 'LANGUAGE': 'en_US:en', 12:48:15 INFO - 'LOGNAME': 'cltbld', 12:48:15 INFO - 'MAIL': '/var/mail/cltbld', 12:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:15 INFO - 'MOZ_NO_REMOTE': '1', 12:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:15 INFO - 'NO_EM_RESTART': '1', 12:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:15 INFO - 'PWD': '/builds/slave/test', 12:48:15 INFO - 'SHELL': '/bin/bash', 12:48:15 INFO - 'SHLVL': '1', 12:48:15 INFO - 'TERM': 'linux', 12:48:15 INFO - 'TMOUT': '86400', 12:48:15 INFO - 'USER': 'cltbld', 12:48:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:15 INFO - '_': '/tools/buildbot/bin/python'} 12:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:15 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 12:48:15 INFO - Cleaning up... 12:48:15 INFO - Return code: 0 12:48:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:15 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:15 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 12:48:15 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 12:48:15 INFO - Using env: {'DISPLAY': ':0', 12:48:15 INFO - 'HOME': '/home/cltbld', 12:48:15 INFO - 'LANG': 'en_US.UTF-8', 12:48:15 INFO - 'LANGUAGE': 'en_US:en', 12:48:15 INFO - 'LOGNAME': 'cltbld', 12:48:15 INFO - 'MAIL': '/var/mail/cltbld', 12:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:15 INFO - 'MOZ_NO_REMOTE': '1', 12:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:15 INFO - 'NO_EM_RESTART': '1', 12:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:15 INFO - 'PWD': '/builds/slave/test', 12:48:15 INFO - 'SHELL': '/bin/bash', 12:48:15 INFO - 'SHLVL': '1', 12:48:15 INFO - 'TERM': 'linux', 12:48:15 INFO - 'TMOUT': '86400', 12:48:15 INFO - 'USER': 'cltbld', 12:48:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:15 INFO - '_': '/tools/buildbot/bin/python'} 12:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:15 INFO - Downloading/unpacking psutil>=0.7.1 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:17 INFO - Installing collected packages: psutil 12:48:17 INFO - Running setup.py install for psutil 12:48:17 INFO - building 'psutil._psutil_linux' extension 12:48:17 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 12:48:17 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 12:48:17 INFO - building 'psutil._psutil_posix' extension 12:48:17 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 12:48:17 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 12:48:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:18 INFO - Successfully installed psutil 12:48:18 INFO - Cleaning up... 12:48:18 INFO - Return code: 0 12:48:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:18 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:18 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 12:48:18 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 12:48:18 INFO - Using env: {'DISPLAY': ':0', 12:48:18 INFO - 'HOME': '/home/cltbld', 12:48:18 INFO - 'LANG': 'en_US.UTF-8', 12:48:18 INFO - 'LANGUAGE': 'en_US:en', 12:48:18 INFO - 'LOGNAME': 'cltbld', 12:48:18 INFO - 'MAIL': '/var/mail/cltbld', 12:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:18 INFO - 'MOZ_NO_REMOTE': '1', 12:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:18 INFO - 'NO_EM_RESTART': '1', 12:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:18 INFO - 'PWD': '/builds/slave/test', 12:48:18 INFO - 'SHELL': '/bin/bash', 12:48:18 INFO - 'SHLVL': '1', 12:48:18 INFO - 'TERM': 'linux', 12:48:18 INFO - 'TMOUT': '86400', 12:48:18 INFO - 'USER': 'cltbld', 12:48:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:18 INFO - '_': '/tools/buildbot/bin/python'} 12:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:48:18 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 12:48:18 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 12:48:18 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 12:48:18 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 12:48:18 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 12:48:18 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 12:48:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:48:20 INFO - Installing collected packages: mozsystemmonitor 12:48:20 INFO - Running setup.py install for mozsystemmonitor 12:48:20 INFO - Successfully installed mozsystemmonitor 12:48:20 INFO - Cleaning up... 12:48:20 INFO - Return code: 0 12:48:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:20 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')]} 12:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:20 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')]} 12:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:20 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:20 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 12:48:20 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 12:48:20 INFO - Using env: {'DISPLAY': ':0', 12:48:20 INFO - 'HOME': '/home/cltbld', 12:48:20 INFO - 'LANG': 'en_US.UTF-8', 12:48:20 INFO - 'LANGUAGE': 'en_US:en', 12:48:20 INFO - 'LOGNAME': 'cltbld', 12:48:20 INFO - 'MAIL': '/var/mail/cltbld', 12:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:20 INFO - 'MOZ_NO_REMOTE': '1', 12:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:20 INFO - 'NO_EM_RESTART': '1', 12:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:20 INFO - 'PWD': '/builds/slave/test', 12:48:20 INFO - 'SHELL': '/bin/bash', 12:48:20 INFO - 'SHLVL': '1', 12:48:20 INFO - 'TERM': 'linux', 12:48:20 INFO - 'TMOUT': '86400', 12:48:20 INFO - 'USER': 'cltbld', 12:48:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:20 INFO - '_': '/tools/buildbot/bin/python'} 12:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:20 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:20 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 12:48:20 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 12:48:20 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 12:48:20 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 12:48:20 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 12:48:20 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 12:48:22 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:23 INFO - Downloading docopt-0.6.1.tar.gz 12:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:23 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:23 INFO - Running setup.py install for blobuploader 12:48:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:23 INFO - Running setup.py install for requests 12:48:23 INFO - Running setup.py install for docopt 12:48:23 INFO - Successfully installed blobuploader requests docopt 12:48:23 INFO - Cleaning up... 12:48:23 INFO - Return code: 0 12:48:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:23 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')]} 12:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:23 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')]} 12:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:23 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:23 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 12:48:23 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 12:48:23 INFO - Using env: {'DISPLAY': ':0', 12:48:23 INFO - 'HOME': '/home/cltbld', 12:48:23 INFO - 'LANG': 'en_US.UTF-8', 12:48:23 INFO - 'LANGUAGE': 'en_US:en', 12:48:23 INFO - 'LOGNAME': 'cltbld', 12:48:23 INFO - 'MAIL': '/var/mail/cltbld', 12:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:23 INFO - 'MOZ_NO_REMOTE': '1', 12:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:23 INFO - 'NO_EM_RESTART': '1', 12:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:23 INFO - 'PWD': '/builds/slave/test', 12:48:23 INFO - 'SHELL': '/bin/bash', 12:48:23 INFO - 'SHLVL': '1', 12:48:23 INFO - 'TERM': 'linux', 12:48:23 INFO - 'TMOUT': '86400', 12:48:23 INFO - 'USER': 'cltbld', 12:48:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:23 INFO - '_': '/tools/buildbot/bin/python'} 12:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:24 INFO - Running setup.py (path:/tmp/pip-sjWION-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:24 INFO - Running setup.py (path:/tmp/pip-nTMa56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:24 INFO - Running setup.py (path:/tmp/pip-TR87Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:24 INFO - Running setup.py (path:/tmp/pip-CAt3rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:24 INFO - Running setup.py (path:/tmp/pip-GZnmAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:24 INFO - Running setup.py (path:/tmp/pip-e2qJB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:24 INFO - Running setup.py (path:/tmp/pip-LpccXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:24 INFO - Running setup.py (path:/tmp/pip-dhNNrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:24 INFO - Running setup.py (path:/tmp/pip-iW95E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:24 INFO - Running setup.py (path:/tmp/pip-w12LFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:24 INFO - Running setup.py (path:/tmp/pip-5LwpSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:24 INFO - Running setup.py (path:/tmp/pip-6YKj5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:24 INFO - Running setup.py (path:/tmp/pip-7L3y9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:25 INFO - Running setup.py (path:/tmp/pip-ORVCXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:25 INFO - Running setup.py (path:/tmp/pip-UgQI80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:25 INFO - Running setup.py (path:/tmp/pip-0NHeG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:25 INFO - Running setup.py (path:/tmp/pip-LoArgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:25 INFO - Running setup.py install for manifestparser 12:48:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:25 INFO - Running setup.py install for mozcrash 12:48:25 INFO - Running setup.py install for mozdebug 12:48:25 INFO - Running setup.py install for mozdevice 12:48:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:25 INFO - Running setup.py install for mozfile 12:48:25 INFO - Running setup.py install for mozhttpd 12:48:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:25 INFO - Running setup.py install for mozinfo 12:48:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Running setup.py install for mozInstall 12:48:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Running setup.py install for mozleak 12:48:26 INFO - Running setup.py install for mozlog 12:48:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Running setup.py install for moznetwork 12:48:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Running setup.py install for mozprocess 12:48:26 INFO - Running setup.py install for mozprofile 12:48:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Running setup.py install for mozrunner 12:48:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:26 INFO - Running setup.py install for mozscreenshot 12:48:26 INFO - Running setup.py install for moztest 12:48:26 INFO - Running setup.py install for mozversion 12:48:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:27 INFO - Cleaning up... 12:48:27 INFO - Return code: 0 12:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:27 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:27 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 12:48:27 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 12:48:27 INFO - Using env: {'DISPLAY': ':0', 12:48:27 INFO - 'HOME': '/home/cltbld', 12:48:27 INFO - 'LANG': 'en_US.UTF-8', 12:48:27 INFO - 'LANGUAGE': 'en_US:en', 12:48:27 INFO - 'LOGNAME': 'cltbld', 12:48:27 INFO - 'MAIL': '/var/mail/cltbld', 12:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:27 INFO - 'MOZ_NO_REMOTE': '1', 12:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:27 INFO - 'NO_EM_RESTART': '1', 12:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:27 INFO - 'PWD': '/builds/slave/test', 12:48:27 INFO - 'SHELL': '/bin/bash', 12:48:27 INFO - 'SHLVL': '1', 12:48:27 INFO - 'TERM': 'linux', 12:48:27 INFO - 'TMOUT': '86400', 12:48:27 INFO - 'USER': 'cltbld', 12:48:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:27 INFO - '_': '/tools/buildbot/bin/python'} 12:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:27 INFO - Running setup.py (path:/tmp/pip-UDL7U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:27 INFO - Running setup.py (path:/tmp/pip-pUvzfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:27 INFO - Running setup.py (path:/tmp/pip-SpjaDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:27 INFO - Running setup.py (path:/tmp/pip-caaVPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:27 INFO - Running setup.py (path:/tmp/pip-aPJtEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:27 INFO - Running setup.py (path:/tmp/pip-CI8Xhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:27 INFO - Running setup.py (path:/tmp/pip-O93w1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:27 INFO - Running setup.py (path:/tmp/pip-eqg7Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:27 INFO - Running setup.py (path:/tmp/pip-cze_Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:27 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)) 12:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:27 INFO - Running setup.py (path:/tmp/pip-TtCyuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:28 INFO - Running setup.py (path:/tmp/pip-GlSav_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:28 INFO - Running setup.py (path:/tmp/pip-2LYYIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:28 INFO - Running setup.py (path:/tmp/pip-iD74l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:28 INFO - Running setup.py (path:/tmp/pip-AOjnAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:28 INFO - Running setup.py (path:/tmp/pip-7AcnsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:28 INFO - Running setup.py (path:/tmp/pip-yMn4Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:28 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)) 12:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:28 INFO - Running setup.py (path:/tmp/pip-i4PAI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:28 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)) 12:48:28 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)) 12:48:28 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)) 12:48:28 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)) 12:48:28 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)) 12:48:28 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)) 12:48:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48:28 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 12:48:28 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 12:48:28 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 12:48:28 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 12:48:28 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 12:48:28 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 12:48:30 INFO - Downloading blessings-1.6.tar.gz 12:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:30 INFO - Installing collected packages: blessings 12:48:30 INFO - Running setup.py install for blessings 12:48:30 INFO - Successfully installed blessings 12:48:30 INFO - Cleaning up... 12:48:30 INFO - Return code: 0 12:48:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:30 INFO - Reading from file tmpfile_stdout 12:48:30 INFO - Current package versions: 12:48:30 INFO - argparse == 1.2.1 12:48:30 INFO - blessings == 1.6 12:48:30 INFO - blobuploader == 1.2.4 12:48:30 INFO - docopt == 0.6.1 12:48:30 INFO - manifestparser == 1.1 12:48:30 INFO - mozInstall == 1.12 12:48:30 INFO - mozcrash == 0.17 12:48:30 INFO - mozdebug == 0.1 12:48:30 INFO - mozdevice == 0.48 12:48:30 INFO - mozfile == 1.2 12:48:30 INFO - mozhttpd == 0.7 12:48:30 INFO - mozinfo == 0.9 12:48:30 INFO - mozleak == 0.1 12:48:30 INFO - mozlog == 3.1 12:48:30 INFO - moznetwork == 0.27 12:48:30 INFO - mozprocess == 0.22 12:48:30 INFO - mozprofile == 0.28 12:48:30 INFO - mozrunner == 6.11 12:48:30 INFO - mozscreenshot == 0.1 12:48:30 INFO - mozsystemmonitor == 0.0 12:48:30 INFO - moztest == 0.7 12:48:30 INFO - mozversion == 1.4 12:48:30 INFO - psutil == 3.1.1 12:48:30 INFO - requests == 1.2.3 12:48:30 INFO - wsgiref == 0.1.2 12:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:30 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:30 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 12:48:30 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 12:48:30 INFO - Using env: {'DISPLAY': ':0', 12:48:30 INFO - 'HOME': '/home/cltbld', 12:48:30 INFO - 'LANG': 'en_US.UTF-8', 12:48:30 INFO - 'LANGUAGE': 'en_US:en', 12:48:30 INFO - 'LOGNAME': 'cltbld', 12:48:30 INFO - 'MAIL': '/var/mail/cltbld', 12:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:30 INFO - 'MOZ_NO_REMOTE': '1', 12:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:30 INFO - 'NO_EM_RESTART': '1', 12:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:30 INFO - 'PWD': '/builds/slave/test', 12:48:30 INFO - 'SHELL': '/bin/bash', 12:48:30 INFO - 'SHLVL': '1', 12:48:30 INFO - 'TERM': 'linux', 12:48:30 INFO - 'TMOUT': '86400', 12:48:30 INFO - 'USER': 'cltbld', 12:48:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:30 INFO - '_': '/tools/buildbot/bin/python'} 12:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 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)) 12:48:31 INFO - Cleaning up... 12:48:31 INFO - Return code: 0 12:48:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:31 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:31 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 12:48:31 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 12:48:31 INFO - Using env: {'DISPLAY': ':0', 12:48:31 INFO - 'HOME': '/home/cltbld', 12:48:31 INFO - 'LANG': 'en_US.UTF-8', 12:48:31 INFO - 'LANGUAGE': 'en_US:en', 12:48:31 INFO - 'LOGNAME': 'cltbld', 12:48:31 INFO - 'MAIL': '/var/mail/cltbld', 12:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:31 INFO - 'MOZ_NO_REMOTE': '1', 12:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:31 INFO - 'NO_EM_RESTART': '1', 12:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:31 INFO - 'PWD': '/builds/slave/test', 12:48:31 INFO - 'SHELL': '/bin/bash', 12:48:31 INFO - 'SHLVL': '1', 12:48:31 INFO - 'TERM': 'linux', 12:48:31 INFO - 'TMOUT': '86400', 12:48:31 INFO - 'USER': 'cltbld', 12:48:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:31 INFO - '_': '/tools/buildbot/bin/python'} 12:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:31 INFO - Downloading/unpacking jsonschema 12:48:31 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 12:48:31 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 12:48:31 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 12:48:31 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 12:48:31 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 12:48:31 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 12:48:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:33 INFO - Downloading/unpacking functools32 (from jsonschema) 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:33 INFO - warning: no files found matching '*.txt' 12:48:33 INFO - no previously-included directories found matching 'build' 12:48:33 INFO - no previously-included directories found matching 'dist' 12:48:33 INFO - no previously-included directories found matching '.git*' 12:48:33 INFO - Installing collected packages: jsonschema, functools32 12:48:33 INFO - Running setup.py install for functools32 12:48:33 INFO - warning: no files found matching '*.txt' 12:48:33 INFO - no previously-included directories found matching 'build' 12:48:33 INFO - no previously-included directories found matching 'dist' 12:48:33 INFO - no previously-included directories found matching '.git*' 12:48:33 INFO - Successfully installed jsonschema functools32 12:48:33 INFO - Cleaning up... 12:48:33 INFO - Return code: 0 12:48:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:48:33 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')]} 12:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:33 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')]} 12:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:33 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 0x7fab2423af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16045a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', '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 12:48:33 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 12:48:33 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 12:48:33 INFO - Using env: {'DISPLAY': ':0', 12:48:33 INFO - 'HOME': '/home/cltbld', 12:48:33 INFO - 'LANG': 'en_US.UTF-8', 12:48:33 INFO - 'LANGUAGE': 'en_US:en', 12:48:33 INFO - 'LOGNAME': 'cltbld', 12:48:33 INFO - 'MAIL': '/var/mail/cltbld', 12:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:33 INFO - 'MOZ_NO_REMOTE': '1', 12:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:33 INFO - 'NO_EM_RESTART': '1', 12:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:33 INFO - 'PWD': '/builds/slave/test', 12:48:33 INFO - 'SHELL': '/bin/bash', 12:48:33 INFO - 'SHLVL': '1', 12:48:33 INFO - 'TERM': 'linux', 12:48:33 INFO - 'TMOUT': '86400', 12:48:33 INFO - 'USER': 'cltbld', 12:48:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:33 INFO - '_': '/tools/buildbot/bin/python'} 12:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:33 INFO - Downloading/unpacking flake8 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 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 12:48:33 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 12:48:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:48:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:48:35 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 12:48:35 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 12:48:35 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 12:48:35 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 12:48:35 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 12:48:35 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 12:48:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:48:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:48:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:48:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:48:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:48:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:48:36 INFO - no previously-included directories found matching 'docs/_build' 12:48:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:48:36 INFO - Running setup.py install for pep8 12:48:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:48:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:48:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:48:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:48:36 INFO - no previously-included directories found matching 'docs/_build' 12:48:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:48:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:48:36 INFO - Cleaning up... 12:48:36 INFO - Return code: 0 12:48:36 INFO - Running post-action listener: _resource_record_post_action 12:48:36 INFO - Running post-action listener: _start_resource_monitoring 12:48:36 INFO - Starting resource monitoring. 12:48:36 INFO - ##### 12:48:36 INFO - ##### Running install step. 12:48:36 INFO - ##### 12:48:36 INFO - Running pre-action listener: _resource_record_pre_action 12:48:36 INFO - Running main action method: install 12:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:36 INFO - Reading from file tmpfile_stdout 12:48:36 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:37 INFO - Reading from file tmpfile_stdout 12:48:37 INFO - Output received: 12:48:37 INFO - Usage: mozinstall [options] installer 12:48:37 INFO - Options: 12:48:37 INFO - -h, --help show this help message and exit 12:48:37 INFO - -d DEST, --destination=DEST 12:48:37 INFO - Directory to install application into. [default: 12:48:37 INFO - "/builds/slave/test"] 12:48:37 INFO - --app=APP Application being installed. [default: firefox] 12:48:37 INFO - mkdir: /builds/slave/test/build/application 12:48:37 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'] 12:48:37 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 12:48:52 INFO - Reading from file tmpfile_stdout 12:48:52 INFO - Output received: 12:48:52 INFO - /builds/slave/test/build/application/firefox/firefox 12:48:52 INFO - Running post-action listener: _resource_record_post_action 12:48:52 INFO - ##### 12:48:52 INFO - ##### Running run-tests step. 12:48:52 INFO - ##### 12:48:52 INFO - Running pre-action listener: _resource_record_pre_action 12:48:52 INFO - Running main action method: run_tests 12:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:48:52 INFO - Python 2.7.3 12:48:52 INFO - Return code: 0 12:48:52 INFO - grabbing minidump binary from tooltool 12:48: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')]} 12:48:52 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 0x1693410>, '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 0x1694310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16947a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:48:52 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 12:48:52 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 12:48:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:48:52 INFO - Return code: 0 12:48:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:48:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:48:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:48:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:48:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:48:53 INFO - Return code: 0 12:48:53 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/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 12:48:53 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/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 12:48:53 INFO - Using env: {'DISPLAY': ':0', 12:48:53 INFO - 'HOME': '/home/cltbld', 12:48:53 INFO - 'LANG': 'en_US.UTF-8', 12:48:53 INFO - 'LANGUAGE': 'en_US:en', 12:48:53 INFO - 'LOGNAME': 'cltbld', 12:48:53 INFO - 'MAIL': '/var/mail/cltbld', 12:48:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:48:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:53 INFO - 'MOZ_NO_REMOTE': '1', 12:48:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:53 INFO - 'NO_EM_RESTART': '1', 12:48:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:53 INFO - 'PWD': '/builds/slave/test', 12:48:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:48:53 INFO - 'SHELL': '/bin/bash', 12:48:53 INFO - 'SHLVL': '1', 12:48:53 INFO - 'TERM': 'linux', 12:48:53 INFO - 'TMOUT': '86400', 12:48:53 INFO - 'USER': 'cltbld', 12:48:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846', 12:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:53 INFO - '_': '/tools/buildbot/bin/python'} 12:48:53 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/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 12:48:54 INFO - mozversion application_buildid: 20160424114349 12:48:54 INFO - mozversion application_changeset: a07ea7fb572f503761e11fdae02f6d0340f157ec 12:48:54 INFO - mozversion application_display_name: Nightly 12:48:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:48:54 INFO - mozversion application_name: Firefox 12:48:54 INFO - mozversion application_remotingname: firefox 12:48:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:48:54 INFO - mozversion application_vendor: Mozilla 12:48:54 INFO - mozversion application_version: 48.0a1 12:48:54 INFO - mozversion platform_buildid: 20160424114349 12:48:54 INFO - mozversion platform_changeset: a07ea7fb572f503761e11fdae02f6d0340f157ec 12:48:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:48:54 INFO - mozversion platform_version: 48.0a1 12:48:54 INFO - using testdate: 1461527334 12:48:54 INFO - actual date: 1461527334 12:48:54 INFO - starting webserver on 'localhost:51934' 12:48:54 INFO - SUITE-START | Running 2 tests 12:48:54 INFO - TEST-START | dromaeo_css 12:48:54 INFO - operating with platform_type : linux_ 12:48:54 INFO - Initialising browser for dromaeo_css test... 12:48:54 INFO - TEST-INFO | started process 26449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5zJgg/profile http://localhost:51934/getInfo.html) 12:48:58 INFO - PROCESS | 26449 | 12:48:58 INFO - PROCESS | 26449 | (process:26514): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:48:59 INFO - PROCESS | 26449 | __metrics Screen width/height:1600/1200 12:48:59 INFO - PROCESS | 26449 | colorDepth:24 12:48:59 INFO - PROCESS | 26449 | Browser inner width/height: 1024/697 12:48:59 INFO - PROCESS | 26449 | __metrics 12:48:59 ERROR - PROCESS | 26449 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:49:00 INFO - TEST-INFO | 26449: exit 0 12:49:00 INFO - Browser initialized. 12:49:00 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:01 INFO - TEST-INFO | started process 26566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps5zJgg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:03 INFO - PROCESS | 26566 | 12:49:03 INFO - PROCESS | 26566 | (process:26625): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:49:13 INFO - PROCESS | 26566 | RSS: Main: 165425152 12:49:13 INFO - PROCESS | 26566 | 12:50:02 INFO - PROCESS | 26566 | 1461527402634 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] 12:52:14 INFO - PROCESS | 26566 | Cycle 1(1): loaded http://localhost:51934/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51934/tests/dromaeo/cssquery-ext.html) 12:52:15 INFO - PROCESS | 26566 | RSS: Main: 171360256 12:52:15 INFO - PROCESS | 26566 | 12:55:17 INFO - PROCESS | 26566 | Cycle 1(1): loaded http://localhost:51934/tests/dromaeo/cssquery-ext.html (next: http://localhost:51934/tests/dromaeo/cssquery-jquery.html) 12:55:18 INFO - PROCESS | 26566 | RSS: Main: 166735872 12:55:18 INFO - PROCESS | 26566 | 12:58:19 INFO - PROCESS | 26566 | Cycle 1(1): loaded http://localhost:51934/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51934/tests/dromaeo/cssquery-mootools.html) 12:58:20 INFO - PROCESS | 26566 | RSS: Main: 167841792 12:58:20 INFO - PROCESS | 26566 | 13:01:22 INFO - PROCESS | 26566 | Cycle 1(1): loaded http://localhost:51934/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51934/tests/dromaeo/cssquery-prototype.html) 13:01:22 INFO - PROCESS | 26566 | RSS: Main: 164999168 13:01:22 INFO - PROCESS | 26566 | 13:04:25 INFO - PROCESS | 26566 | Cycle 1(1): loaded http://localhost:51934/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51934/tests/dromaeo/cssquery-yui.html) 13:04:26 INFO - PROCESS | 26566 | RSS: Main: 166625280 13:04:26 INFO - PROCESS | 26566 | 13:07:28 INFO - PROCESS | 26566 | Cycle 1(1): loaded http://localhost:51934/tests/dromaeo/cssquery-yui.html (next: http://localhost:51934/tests/dromaeo/cssquery-dojo.html) 13:07:29 INFO - PROCESS | 26566 | RSS: Main: 168427520 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | __start_tp_report 13:07:29 INFO - PROCESS | 26566 | _x_x_mozilla_page_load 13:07:29 INFO - PROCESS | 26566 | _x_x_mozilla_page_load_details 13:07:29 INFO - PROCESS | 26566 | |i|pagename|runs| 13:07:29 INFO - PROCESS | 26566 | |0;dojo.html;2627.921162365129;2663.9866800666;2700.4194098268867;2707.309636042809;2711.159540542433;4736.786844591998;4761.71429714217;4765.761711914408;4780.784864681089;4839.201531747258;4705.83529576464;4766.976165119169;4814.277858321254;4852.927206091903;4887.242477415997;4443.289073748201;4487.147441986012;4538.682292239545;4540.59134677879;4587.0137920347115;4453.421055262811;4530.343100250462;4544.681872268926;4549.067441174568;4573.291139873325;4313.568643135693;4326.6538676905775;4392.516823149451;4471.172833025885;4508.098380323949;4432.401625780511;4461.754603496806;4467.195904737146;4468.5531446855375;4501.212287849613;4404.273294906337;4426.62373698236;4436.534163912807;4436.55634436557;4462.486814016397;4669.089527542131;4729.834455794065;4746.264329029006;4761.904761904777;4787.640926930494;5079.187330027215;5117.897642047175;5133.743312834344;5137.537621614073;5167.534921857014;5107.897842043139;5136.049830781318;5179.507946745053;5182.507661772125;5187.792488300463;4825.710457372498;4838.322634831126;4844.031193761261;4851.733154676526;4904.43598986114;5251.343582052244;5320.547753440924;5327.174287985368;5339.41266460689;5364.839054828361;4988.226824842155;5086.3896332440345;5086.491350864884;5113.181890897438;5172.172452407597;5148.510891465305;5171;5173.32746742921;5174.948250517522;5214.921776173361;5065.062963351792;5094.821681241138;5191.143461328838;5223;5240.3973543042275;4968.378952630921;5052.8484145475695;5101.311322971425;5106.591472682177;5107.514786095315;4379.3430985351815;4381;4386.122775444924;4419.889502762457;4425.5574442556135;3796.848126074926;3816.580176180618;3834.5973672764517;3855.614438556122;3898.2788184186015;4325.52419233884;4375.4968178659865;4382.517923028464;4413.183561041217;4485.708428952108;5188.63679542436;5194.558462530727;5210.088234558937;5239.738013099406;5247.134222853187;4465.12929978651;4465.955340446619;4466.106778644219;4485.304777759453;4511.684182107287;4545.36364908913;4610.354550362952;4662.114198302312;4682.993156471375;4687;4755.358026666425;4770.594499467584;4817.445993710769;4823.662343635911;4828.927566086511;5109.105906466428;5126.231065340229;5129.487051294841;5132.358455193101;5148.639595228298;4763.1426343258545;4847.854564363075;4891.144049791344;4922.926156107733;4935.531124543163;5072.847814565569;5087.389513258433;5102.566281866083;5102.923456148235;5155.02054609623;5047.444781074006;5154.407243167084;5177.922331165111;5193.818216362561;5211.4527974562125;4918.163912134874;5000.949990500048;5025.120603894231;5094.337736094284;5138.4604616514725;4922.8769280768265;4932.753362331798;4952.4057113146655;4956.10790057793;5019.0965626187635;4750.643701722453;4856.611471082376;4868.14807408695;4904.485029072039;4934.037862616899;4921.26181072842;5020.523050310215;5070.087384270867;5087.287779710769;5109.616778741535;4987.675801072919;5001.374828146481;5019.171836647059;5036.320096786887;5074.035933172685 13:07:29 INFO - PROCESS | 26566 | |1;ext.html;585.7686213945492;603.420716112532;617.2747022248857;624.6314674342138;649.5193556767994;35193.64806351936;36431.63568364316;36438.635613643855;36441.817790911075;36645;38416;39323.41014884772;39488.605113948855;39514.8024259879;39591.40612890809;7623.313901748827;7843.529388236724;7845.333146682538;7867.213278672144;7875.724349647735;7594.582297973637;7714.922850771504;7757.224277572254;7759.495632783879;7765.378769698439;7729.574873381962;7779;7780.49426787257;7783.88324175135;7793.961030194841;7718.266764657348;7759.612019399007;7771.145174030852;7773.611319434006;7786;7447.553146811155;7597.088349398053;7618.085829700416;7663.501872378278;7665.965094712254;29831.403371932658;35908.28183436343;36616.45075323872;36652.450213246826;36781.816090919376;3055.2972816252163;3083.383323335342;3200.7439404847555;3211.4058899103507;3250.6749325067303;27513;29612.555811662627;29887;30109.849450752827;30730.385392292254;3208.4545627243424;3290.7367410607094;3306.206510437502;3339.782914110575;3427.725781937439;244669;326330;337985.3100734505;338249;338348;51767.48232517702;52013.7399313001;52210.477895221324;52245;52375.73812130915;55615;64015.679921600095;64998;65724.67137664281;65974;13815.723685526233;13900.235487048107;14024.439022439192;14059;14207.64480887986;10844.403557804397;10914.126869850394;10956.178286628534;10976.451177441255;11017.889821101846;18720.719189212174;18769.53076173079;18821.811781882006;18828.341008064654;19842.70235946462;7470.514416562906;7586.5448073114685;7683.884741728767;7744;7856.685732570748;916.8303863785221;943.4480828715141;1002.3785253142952;1019.4189312092036;1029.2332212501733;28515.714842851306;28554.428911421655;29070.418591628473;29388.265293367836;29418.411631767245;961.7259081161835;1026.0201507560262;1081.0540776820283;1085.9945700271448;1098.5056724474018;14889.553313400615;15465.845341546665;15477;15650.530484085495;15725.528234152993;367138;374095;375297;375989;378141;49011;49443.50556494389;49609;50038.749806251464;50048;1218.8842060004463;1257.1074537078775;1265.4115836136057;1265.829113069742;1275.5726831511547;27031.45937081208;28277.15168544947;28398;28458.57312140361;28718.856405717837;41300.58699412968;41361.79319103385;41605.1678966425;41862.372064419666;41994.58005420029;308554;309820;312725;312734;313927;26333.473330533667;26870.865645671645;41538.37692434555;42618;42830;41464.1707165861;41524.58475415328;41552.79223603863;42168.36747448852;42629.5737042638;34995.300093997466;35923;36157.81921090378;36248.637513624526;36629.450558241115;34857;35061.29877402489;35080.82459587686;35391.82304088463;35419.29161416706;31097.689023110383;35392.29215415729;35716.28567428585;37709.622903770614;37846.43230351492;28625.713742862306;29155.562666559596;29471.55792663069;29673.406531869674;29782.255443613216;23388.298351049496;25104.874475627505;25157.748422515542;25177.74822251754;25381.619275711248 13:07:29 INFO - PROCESS | 26566 | |2;jquery.html;367.8565359509791;370.32785494327794;370.4665281993928;381.0397797550174;387.0073262082759;15588.844111558881;15668.451604193855;16375;16426.917865410673;16483;15819.525414237563;16488.917555412205;17232.138393080328;17247.82752172478;17318.48044558662;5169.612279079065;5279.604029697788;5332.066888294552;5344.251804747319;5346.946530534703;3744.475773391727;5216.113260745663;5830.09633506805;6168.691565421734;6177.042558403455;6053.303870054934;6066.939330606681;6091.116788065728;6099.390060993909;6105;5092.134337162691;5338.492843179892;5365.114756065244;5382.2464854920345;5394.676319420828;5003.649744517885;5208.427073021964;5400.621956463049;5433.831726178851;5435.211894275308;10965.50655220509;11715.53137874484;11722.94138529302;11800.173987820855;11817.290962542274;1835.220031486626;1857.7863545692283;1874.6157037807218;1948.1915005272795;2032.867863588862;8995.730128096167;9149.130832570896;9584.568694408768;11813.822792658117;12962.861182866056;1724.767156433878;1750.2124044180043;1754.7192449208194;1755.9209835557303;1794.1836464408664;68814;70237;71229.28770712278;71447.64276178586;71479.28520714778;10124.13944814699;10130.696079117639;10185.898141018642;10272.948635256926;10284.948575257076;14053.297335133202;14095.436182552789;14148.646283842987;14237.928810355881;14291.42834286617;6786.626735529495;7178.533395329287;7293.307135822089;7398.630068496554;7406.333429991327;6687.963365678328;6711.161104861892;6780.186377634715;6875.7937261882225;6906.516543841984;4363.192809330284;4437.378766972626;4438.156750217513;4477.597016268552;4493.056458143827;1724.9137543122793;1765.796933352681;1835.9443320091002;1878.8872667639985;1885.820847019531;864.4985908173245;875.746033650247;944.4569372610639;962.855571664242;971.2472833554052;15204.16377099248;15838.287277072559;16385;16393.42623008189;16728.330866765195;842.2672275120561;854.4147259127518;860.1742327365674;864.9740507784777;901.6078006067381;8262.628181731836;9270.258379329638;9327.766805829773;9357.344985850925;9504.857427138599;283895;290474;292570;393077;393098;78982.21017789864;81840.59079704683;82806;84848.57575712082;85242.57378713066;956.8038552096804;964.7298756348234;999.7650552120245;1000.3097862474724;1002.4236064263077;14995.250237487864;15082.24588770535;15111.319990600668;15125.470608528649;15541.45604903823;32945.505817412275;33188.668113318556;33490.49764253587;33633.15917102092;34413;41885.37171942362;46378.536214637425;46821.29768053414;47432.2885156716;47701.950208504175;4771.6898401603785;4774.069056534081;6977.860442791014;7901.684749579126;7935.920640793749;8373.413861029669;9925.801483970425;10324.896751032393;10995.395253261147;11077.390743509184;9290;9375.624975001196;9379.296552758708;9456.810863782823;10013.699589012342;9248.907510925073;9269.768255793659;9653;9659;9954.900450995687;9240.907590924005;9431.669891554036;9495.445339080386;9558.23534117255;10061.547230374505;7644.273793989784;7693.88459173124;7707;7714.459987801025;7903.288704016666;9204.493752843659;9574.186194173573;9596.856047159159;9607;9922.751931201488 13:07:29 INFO - PROCESS | 26566 | |3;mootools.html;1444.653283212029;1457.4825936792438;1595.920203989801;1679.6640671865614;1811.4384540792348;6968.303169683029;7178.174509931359;7465.328120469164;7472.589007604586;7592.506487078336;7614.4669873108905;7684.577348245858;7769.883451748228;7781.105172905118;7797;2191.0468946008496;2242.1479837661664;2255.6052690779047;2261.118163916074;2262.049939025613;2180.1388451561625;2207.7129973103474;2227.9665805012937;2228.576570451609;2234.754177040524;2166.5450255446376;2204.0742887987085;2204.5370472200857;2220.578090162864;2242.4842286274165;2122.2198919415614;2132.509522809755;2141.582391433671;2147.9355619331445;2152.655575107975;2155.5150091229507;2161.5136594266164;2166.1876796201423;2180.760116387196;2182.443476913377;7969.920300797034;7996.200379962015;8002.239787220205;8025.719099831478;8035.5580443075605;4679.9298010529865;4838.516148385133;4851.975740121276;4859.684120532154;4866.197077482211;2995.925101872449;3002.579638850563;3019.5168772996435;3046.4973279408873;3126.5622812806228;939.3002213351028;950.6102497975866;961.889382720989;964.5370222293268;967.4050458967755;10544.525496352682;10769.246152769309;10794.892051079467;10809.945950270197;10835.458227088615;4295.935560966588;4310.396544483775;4489.349044388546;4497.392851965008;4538.704984176018;9244.722658320261;9298.53507324631;9316.068393160765;9335.90664093364;9361.531923403803;4817.301491283744;4839.395075615548;4855.44162421319;4860.052289803454;4863.489333619989;3773.6792372648633;4116.958830411718;4233.661307095425;4356.237658409766;4420.977895110504;3730.645588669072;3817.2938006468894;3831.425286207091;3862.362710152793;3865.594112618191;1239.6157191270554;1283.890869276122;1293.224065560656;1293.9935300323439;1294.8122522234223;818.145038434837;845.8435189489965;867.7353407210861;875.470340444035;885.3404213860715;5358.169483730028;5530.391656917735;5531.308586426697;5594.524465420485;5746;416.4149370134965;436.79907242668094;440.5110327536432;441.4570078803026;449.3103086761805;3659.396199627085;3705.2589482103685;3710.703143748494;3797.6771974381936;3832.3868181090893;9373.578188981512;9711.27165462593;9734.464604446823;9798.853017204749;9816.165625921876;9660.32377733552;9666.806663866684;9698.127168554724;9724.027597240362;9728.221742260603;7052.576845389293;7270.781876543712;7386.630668466662;7401.703931842773;7414.221506741822;5269.78920843162;5300.867478313073;5372.865678358073;5375.543078838186;5437.238786569963;8822.426542274732;8864.246539043996;8914.197722205032;8944.239739622206;8956.238719708897;8669.869951950599;9117.225035872025;9178.357514974155;9209.355345125778;9226.215771659485;6203.565750397609;6395.616263024233;6651.135352404156;6937.9653101736185;7000.809862323315;7396.519226250277;7414.480986330905;7467.066616672916;7501.774946751606;7501.849963000818;6529.314421985623;6663.300353462817;6731.865362692816;6746.595204287759;6805.081314022742;6506.544541882212;6551.344865513411;6568.770093046721;6593.868122637617;6704.664766761545;6249.312575616769;6308.463780578702;6340.524460665376;6417.2299324081405;6425.357464253537;4700.882477938079;4863.294822250825;4932.457429682804;5006.123928312458;5007.1487847065355;4839.467658557485;4858.319835223142;4965.503449655005;4999.875003124951;5012 13:07:29 INFO - PROCESS | 26566 | |4;prototype.html;311.7210096963218;316.1653235458389;317.2734438136667;318.69405370844004;327.395954464014;5386.814900721844;5449.56403487721;5460.590455715817;5480.945190548094;5492.588055895809;5350.785968561253;5365.436629153941;5367.597430192742;5371.435999220084;5382.784688612461;3960.2871483133026;4028.5971402859773;4157.916841663165;4164.875053748392;4173.9582604173875;4153.41852140699;4164.0630858057;4164.354525048622;4177.394277829713;4178.895527611804;4153.293940030202;4154.688398370119;4157.3393028461805;4163.7293575917465;4175.123224122923;4005.339119045354;4120.278951183561;4152.148809494047;4152.979235103835;4155.065110350177;3603.549556305462;3621.5835178954494;3628.727845411605;3630.5280313559333;3642.5993140754495;5089;5099.770510327045;5133.28134061228;5133.768980395891;5145.253938178943;4434.623057040156;4681.953180468186;4792.113459010059;4804.879878003043;4817.951820481785;5609.49514543693;5660.745266463019;5663.66018038919;5666.150077488369;5701.71491425427;3882.0877093882914;3887.8250478728523;3906.7069969752383;3918.1380096378753;3923.5487918889407;5844.590878638497;5898.41015898411;5908.615939963888;5937.376575459601;6004.639721616717;3897.376419772879;3913.7847418391693;3919.9216015679526;3929.174873276587;3938.86213982515;3969.2656858481273;3974.4833171687496;3983.462232598562;3990.4014397839974;4003.459532963013;4575.748333841604;4662.743549104764;4672.2057250267535;4678.0410015946645;4694;5676.545876329884;5697.145428185805;5702.686352250583;5704.743286552115;5727.140928860705;1397.9161250325012;1416.8016477693131;1416.971660566783;1417.6455886028493;1419.6096073579847;872.7948932000975;917.9495127768037;922.3313098004028;944;954.3510412919281;4804.399450068741;4807.351007613997;4808.206645903387;4819.759012049383;4822.180229361017;5746.396628354046;5747.339056008613;5752.9424705753245;5803.303603567599;5819.359870414251;4691.413573303337;4833.854984350475;4852.743474284474;4855.247436647325;4966.776495057731;3131.7024882636115;3165.8733650653717;3170;3174.2699179188917;3174.873005079771;5542.2795036644975;5553.666779993213;5559.27729395176;5565.443455654483;5565.554755619622;5950.077737950624;6057.151998720183;6095.908561371494;6125.479334256549;6143.723532441051;5518.172274158908;5534.142207957773;5559.555235581063;5564.4991950724625;5569.805056822992;5684.317881854038;5889.617174883619;5889.646621202742;5902.557308201816;5903.409659034062;5789.131630255495;5814.680192589448;5815.621984570989;5819.243498345188;5856.180134781049;5554.361248456479;5557.749901254534;5558;5568.470995255444;5602.159676048625;3787.14789172434;3981.56202817684;3989.800509974548;4024.3762216856435;4064.5122585289955;5886.6173698709445;5902;5912.640092778599;5933.258342707161;5934.287885453773;5590.636608620427;5692.971535142297;5714.942850571441;5730.856728581819;5784.334801497882;5670.489655930986;5689.630174038674;5705.828825135252;5713.400092990176;5714.20001199824;5311.893762124813;5557.388687244319;5562.249096371938;5589.6366736163645;5622.9718851407115;5563.415841336601;5736.210264429082;5736.885262294814;5739.598228124159;5793.826185214451;5585.553155747449;5610.663360198401;5614.915776263278;5672.347680016685;5683.8863222736145 13:07:29 INFO - PROCESS | 26566 | |5;yui.html;741.9406447484201;756.3117563017655;769.1539306762562;772.6909236305477;776.0958483366878;11381.374024428653;11479.13906457017;11496.310221386702;11518.308901465918;12026.819597706042;12170.269783812977;12216.81674774877;13365.264910429922;13779.44882204713;13790.517331893385;826.1531929771987;836.8200836820082;837.0248660310731;837.7779888329567;838.9496630202208;649.7888186339459;813.4712436915993;820.7906983719143;821.2690705272282;841.3269384492412;872.6596627315321;873.6461732998146;875.9124087591254;876.0626130040858;877.5129802959354;858.6307887608326;865.212656482601;865.7835541114721;868.2663149638609;868.9087645797226;628.7045088808298;629.2857606616477;629.512128100721;629.804760524239;631.3307893632764;13100.803487947689;13226.735465290736;13228.27244501552;13242.139260948104;13257.933710331483;12410.689732756662;12438.19151755133;12471.251724896536;12674.74650506994;12911.741765164645;10095.192384609214;10147.188224941987;10197.898021019842;10225.38647681134;10257.43584102874;3293.7035666790102;3307.9173020674675;3338.232206592473;3342.1644588852787;3439.724822014258;47857.521424786006;47983.28025079626;48185;48452.757736211446;48842.26736598954;9562.426254424758;9680.903190968142;9732.367396119229;9763.755906102404;9810.75473113178;16471.83528164703;16543.6691266174;16569.42007029748;16583.91708041476;16584.585385365222;6934.202566704793;7027.402670772939;7041.366277035091;7129.322714342129;7219.350258476762;3880.5537363203593;3981.6814654827544;3982.1040265939932;4031.07285324377;4039.071013666873;2823.68939416664;2882.524383476745;2896.4786338458857;2896.6089577907132;2901.448724742292;505.43391401629674;509.7333127178957;512.8640910158811;513.6430181024152;515.6416290677943;553.3636318233982;556.349071586245;601.9247594050744;616.2174038970483;669.9832504187336;7589.620518974029;7982.401319901031;8133.674653013932;8141.185881411811;8256.463329883538;509.20818127811606;526.3420226287226;606.2603623579226;627.5450298533526;655.9048937904073;3766.6798322142376;3971.72197946141;3988.1026768977326;4083.372574289302;4146.398772178018;52903;52950;53025.73487132617;53153.46846531485;53446.46553534415;40171.59828401737;45260;45293.54706452959;46025.079498410516;46641;36982.815085924936;39017.219655607296;40213.39679904804;40394.79802601027;41582.79208603998;8120.715774947848;8220.219079187467;8435.156484351515;8566.18621230982;8624.353173512138;25847.483050339262;26087.478250435266;26907.192784216506;26924.730752692223;26938.730612693624;34247.486287706204;36768.44847327239;38076.428853566664;38533.42199866948;38843.80578097091;10559.683209503728;10582.894171058191;10674.46627668598;10677.9466102669;10840.512176952214;11743.76512469763;11826.46780894879;11868.821967670665;11879.10906681985;12036.578719745117;10157.84763228567;11083.944580277048;11131.387773672526;11332.660020199408;11546.863830191442;10995.395253261147;11025.944870275598;11485.655430337103;11505.712357190803;11910.225835320676;10572.629957951434;10718.571257149626;11051.834222486508;11070.335779853234;11090.611828586283;9816;9870.555824987749;9923.702288931343;9954;10267.435291058764;9391.765205869908;9505.334626576074;9565.204358447843;9568.4737339447;9688.32181747271 13:07:29 INFO - PROCESS | 26566 | __end_tp_report 13:07:29 INFO - PROCESS | 26566 | __start_cc_report 13:07:29 INFO - PROCESS | 26566 | _x_x_mozilla_cycle_collect,362 13:07:29 INFO - PROCESS | 26566 | __end_cc_report 13:07:29 INFO - PROCESS | 26566 | __startTimestamp1461528449039__endTimestamp 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | ------- Summary: start ------- 13:07:29 INFO - PROCESS | 26566 | Number of tests: 6 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | [#0] dojo.html Cycles:165 Average:4765.45 Median:4868.15 stddev:496.49 (10.2%) stddev-sans-first:468.85 13:07:29 INFO - PROCESS | 26566 | Values: 2627.9 2664.0 2700.4 2707.3 2711.2 4736.8 4761.7 4765.8 4780.8 4839.2 4705.8 4767.0 4814.3 4852.9 4887.2 4443.3 4487.1 4538.7 4540.6 4587.0 4453.4 4530.3 4544.7 4549.1 4573.3 4313.6 4326.7 4392.5 4471.2 4508.1 4432.4 4461.8 4467.2 4468.6 4501.2 4404.3 4426.6 4436.5 4436.6 4462.5 4669.1 4729.8 4746.3 4761.9 4787.6 5079.2 5117.9 5133.7 5137.5 5167.5 5107.9 5136.0 5179.5 5182.5 5187.8 4825.7 4838.3 4844.0 4851.7 4904.4 5251.3 5320.5 5327.2 5339.4 5364.8 4988.2 5086.4 5086.5 5113.2 5172.2 5148.5 5171.0 5173.3 5174.9 5214.9 5065.1 5094.8 5191.1 5223.0 5240.4 4968.4 5052.8 5101.3 5106.6 5107.5 4379.3 4381.0 4386.1 4419.9 4425.6 3796.8 3816.6 3834.6 3855.6 3898.3 4325.5 4375.5 4382.5 4413.2 4485.7 5188.6 5194.6 5210.1 5239.7 5247.1 4465.1 4466.0 4466.1 4485.3 4511.7 4545.4 4610.4 4662.1 4683.0 4687.0 4755.4 4770.6 4817.4 4823.7 4828.9 5109.1 5126.2 5129.5 5132.4 5148.6 4763.1 4847.9 4891.1 4922.9 4935.5 5072.8 5087.4 5102.6 5102.9 5155.0 5047.4 5154.4 5177.9 5193.8 5211.5 4918.2 5000.9 5025.1 5094.3 5138.5 4922.9 4932.8 4952.4 4956.1 5019.1 4750.6 4856.6 4868.1 4904.5 4934.0 4921.3 5020.5 5070.1 5087.3 5109.6 4987.7 5001.4 5019.2 5036.3 5074.0 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | [#1] ext.html Cycles:180 Average:48936.76 Median:35915.64 stddev:88432.97 (246.2%) stddev-sans-first:88606.53 13:07:29 INFO - PROCESS | 26566 | Values: 585.8 603.4 617.3 624.6 649.5 35193.6 36431.6 36438.6 36441.8 36645.0 38416.0 39323.4 39488.6 39514.8 39591.4 7623.3 7843.5 7845.3 7867.2 7875.7 7594.6 7714.9 7757.2 7759.5 7765.4 7729.6 7779.0 7780.5 7783.9 7794.0 7718.3 7759.6 7771.1 7773.6 7786.0 7447.6 7597.1 7618.1 7663.5 7666.0 29831.4 35908.3 36616.5 36652.5 36781.8 3055.3 3083.4 3200.7 3211.4 3250.7 27513.0 29612.6 29887.0 30109.8 30730.4 3208.5 3290.7 3306.2 3339.8 3427.7 244669.0 326330.0 337985.3 338249.0 338348.0 51767.5 52013.7 52210.5 52245.0 52375.7 55615.0 64015.7 64998.0 65724.7 65974.0 13815.7 13900.2 14024.4 14059.0 14207.6 10844.4 10914.1 10956.2 10976.5 11017.9 18720.7 18769.5 18821.8 18828.3 19842.7 7470.5 7586.5 7683.9 7744.0 7856.7 916.8 943.4 1002.4 1019.4 1029.2 28515.7 28554.4 29070.4 29388.3 29418.4 961.7 1026.0 1081.1 1086.0 1098.5 14889.6 15465.8 15477.0 15650.5 15725.5 367138.0 374095.0 375297.0 375989.0 378141.0 49011.0 49443.5 49609.0 50038.7 50048.0 1218.9 1257.1 1265.4 1265.8 1275.6 27031.5 28277.2 28398.0 28458.6 28718.9 41300.6 41361.8 41605.2 41862.4 41994.6 308554.0 309820.0 312725.0 312734.0 313927.0 26333.5 26870.9 41538.4 42618.0 42830.0 41464.2 41524.6 41552.8 42168.4 42629.6 34995.3 35923.0 36157.8 36248.6 36629.5 34857.0 35061.3 35080.8 35391.8 35419.3 31097.7 35392.3 35716.3 37709.6 37846.4 28625.7 29155.6 29471.6 29673.4 29782.3 23388.3 25104.9 25157.7 25177.7 25381.6 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | [#2] jquery.html Cycles:180 Average:22234.74 Median:5212.27 stddev:55867.80 (1071.9%) stddev-sans-first:56000.40 13:07:29 INFO - PROCESS | 26566 | Values: 367.9 370.3 370.5 381.0 387.0 15588.8 15668.5 16375.0 16426.9 16483.0 15819.5 16488.9 17232.1 17247.8 17318.5 5169.6 5279.6 5332.1 5344.3 5346.9 3744.5 5216.1 5830.1 6168.7 6177.0 6053.3 6066.9 6091.1 6099.4 6105.0 5092.1 5338.5 5365.1 5382.2 5394.7 5003.6 5208.4 5400.6 5433.8 5435.2 10965.5 11715.5 11722.9 11800.2 11817.3 1835.2 1857.8 1874.6 1948.2 2032.9 8995.7 9149.1 9584.6 11813.8 12962.9 1724.8 1750.2 1754.7 1755.9 1794.2 68814.0 70237.0 71229.3 71447.6 71479.3 10124.1 10130.7 10185.9 10272.9 10284.9 14053.3 14095.4 14148.6 14237.9 14291.4 6786.6 7178.5 7293.3 7398.6 7406.3 6688.0 6711.2 6780.2 6875.8 6906.5 4363.2 4437.4 4438.2 4477.6 4493.1 1724.9 1765.8 1835.9 1878.9 1885.8 864.5 875.7 944.5 962.9 971.2 15204.2 15838.3 16385.0 16393.4 16728.3 842.3 854.4 860.2 865.0 901.6 8262.6 9270.3 9327.8 9357.3 9504.9 283895.0 290474.0 292570.0 393077.0 393098.0 78982.2 81840.6 82806.0 84848.6 85242.6 956.8 964.7 999.8 1000.3 1002.4 14995.3 15082.2 15111.3 15125.5 15541.5 32945.5 33188.7 33490.5 33633.2 34413.0 41885.4 46378.5 46821.3 47432.3 47702.0 4771.7 4774.1 6977.9 7901.7 7935.9 8373.4 9925.8 10324.9 10995.4 11077.4 9290.0 9375.6 9379.3 9456.8 10013.7 9248.9 9269.8 9653.0 9659.0 9954.9 9240.9 9431.7 9495.4 9558.2 10061.5 7644.3 7693.9 7707.0 7714.5 7903.3 9204.5 9574.2 9596.9 9607.0 9922.8 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | [#3] mootools.html Cycles:180 Average:5201.20 Median:5285.33 stddev:2880.58 (54.5%) stddev-sans-first:2874.83 13:07:29 INFO - PROCESS | 26566 | Values: 1444.7 1457.5 1595.9 1679.7 1811.4 6968.3 7178.2 7465.3 7472.6 7592.5 7614.5 7684.6 7769.9 7781.1 7797.0 2191.0 2242.1 2255.6 2261.1 2262.0 2180.1 2207.7 2228.0 2228.6 2234.8 2166.5 2204.1 2204.5 2220.6 2242.5 2122.2 2132.5 2141.6 2147.9 2152.7 2155.5 2161.5 2166.2 2180.8 2182.4 7969.9 7996.2 8002.2 8025.7 8035.6 4679.9 4838.5 4852.0 4859.7 4866.2 2995.9 3002.6 3019.5 3046.5 3126.6 939.3 950.6 961.9 964.5 967.4 10544.5 10769.2 10794.9 10809.9 10835.5 4295.9 4310.4 4489.3 4497.4 4538.7 9244.7 9298.5 9316.1 9335.9 9361.5 4817.3 4839.4 4855.4 4860.1 4863.5 3773.7 4117.0 4233.7 4356.2 4421.0 3730.6 3817.3 3831.4 3862.4 3865.6 1239.6 1283.9 1293.2 1294.0 1294.8 818.1 845.8 867.7 875.5 885.3 5358.2 5530.4 5531.3 5594.5 5746.0 416.4 436.8 440.5 441.5 449.3 3659.4 3705.3 3710.7 3797.7 3832.4 9373.6 9711.3 9734.5 9798.9 9816.2 9660.3 9666.8 9698.1 9724.0 9728.2 7052.6 7270.8 7386.6 7401.7 7414.2 5269.8 5300.9 5372.9 5375.5 5437.2 8822.4 8864.2 8914.2 8944.2 8956.2 8669.9 9117.2 9178.4 9209.4 9226.2 6203.6 6395.6 6651.1 6938.0 7000.8 7396.5 7414.5 7467.1 7501.8 7501.8 6529.3 6663.3 6731.9 6746.6 6805.1 6506.5 6551.3 6568.8 6593.9 6704.7 6249.3 6308.5 6340.5 6417.2 6425.4 4700.9 4863.3 4932.5 5006.1 5007.1 4839.5 4858.3 4965.5 4999.9 5012.0 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | [#4] prototype.html Cycles:180 Average:4677.45 Median:5384.80 stddev:1397.98 (26.0%) stddev-sans-first:1362.95 13:07:29 INFO - PROCESS | 26566 | Values: 311.7 316.2 317.3 318.7 327.4 5386.8 5449.6 5460.6 5480.9 5492.6 5350.8 5365.4 5367.6 5371.4 5382.8 3960.3 4028.6 4157.9 4164.9 4174.0 4153.4 4164.1 4164.4 4177.4 4178.9 4153.3 4154.7 4157.3 4163.7 4175.1 4005.3 4120.3 4152.1 4153.0 4155.1 3603.5 3621.6 3628.7 3630.5 3642.6 5089.0 5099.8 5133.3 5133.8 5145.3 4434.6 4682.0 4792.1 4804.9 4818.0 5609.5 5660.7 5663.7 5666.2 5701.7 3882.1 3887.8 3906.7 3918.1 3923.5 5844.6 5898.4 5908.6 5937.4 6004.6 3897.4 3913.8 3919.9 3929.2 3938.9 3969.3 3974.5 3983.5 3990.4 4003.5 4575.7 4662.7 4672.2 4678.0 4694.0 5676.5 5697.1 5702.7 5704.7 5727.1 1397.9 1416.8 1417.0 1417.6 1419.6 872.8 917.9 922.3 944.0 954.4 4804.4 4807.4 4808.2 4819.8 4822.2 5746.4 5747.3 5752.9 5803.3 5819.4 4691.4 4833.9 4852.7 4855.2 4966.8 3131.7 3165.9 3170.0 3174.3 3174.9 5542.3 5553.7 5559.3 5565.4 5565.6 5950.1 6057.2 6095.9 6125.5 6143.7 5518.2 5534.1 5559.6 5564.5 5569.8 5684.3 5889.6 5889.6 5902.6 5903.4 5789.1 5814.7 5815.6 5819.2 5856.2 5554.4 5557.7 5558.0 5568.5 5602.2 3787.1 3981.6 3989.8 4024.4 4064.5 5886.6 5902.0 5912.6 5933.3 5934.3 5590.6 5693.0 5714.9 5730.9 5784.3 5670.5 5689.6 5705.8 5713.4 5714.2 5311.9 5557.4 5562.2 5589.6 5623.0 5563.4 5736.2 5736.9 5739.6 5793.8 5585.6 5610.7 5614.9 5672.3 5683.9 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - PROCESS | 26566 | [#5] yui.html Cycles:180 Average:12664.32 Median:22864.60 stddev:14196.89 (62.1%) stddev-sans-first:14208.48 13:07:29 INFO - PROCESS | 26566 | Values: 741.9 756.3 769.2 772.7 776.1 11381.4 11479.1 11496.3 11518.3 12026.8 12170.3 12216.8 13365.3 13779.4 13790.5 826.2 836.8 837.0 837.8 838.9 649.8 813.5 820.8 821.3 841.3 872.7 873.6 875.9 876.1 877.5 858.6 865.2 865.8 868.3 868.9 628.7 629.3 629.5 629.8 631.3 13100.8 13226.7 13228.3 13242.1 13257.9 12410.7 12438.2 12471.3 12674.7 12911.7 10095.2 10147.2 10197.9 10225.4 10257.4 3293.7 3307.9 3338.2 3342.2 3439.7 47857.5 47983.3 48185.0 48452.8 48842.3 9562.4 9680.9 9732.4 9763.8 9810.8 16471.8 16543.7 16569.4 16583.9 16584.6 6934.2 7027.4 7041.4 7129.3 7219.4 3880.6 3981.7 3982.1 4031.1 4039.1 2823.7 2882.5 2896.5 2896.6 2901.4 505.4 509.7 512.9 513.6 515.6 553.4 556.3 601.9 616.2 670.0 7589.6 7982.4 8133.7 8141.2 8256.5 509.2 526.3 606.3 627.5 655.9 3766.7 3971.7 3988.1 4083.4 4146.4 52903.0 52950.0 53025.7 53153.5 53446.5 40171.6 45260.0 45293.5 46025.1 46641.0 36982.8 39017.2 40213.4 40394.8 41582.8 8120.7 8220.2 8435.2 8566.2 8624.4 25847.5 26087.5 26907.2 26924.7 26938.7 34247.5 36768.4 38076.4 38533.4 38843.8 10559.7 10582.9 10674.5 10677.9 10840.5 11743.8 11826.5 11868.8 11879.1 12036.6 10157.8 11083.9 11131.4 11332.7 11546.9 10995.4 11025.9 11485.7 11505.7 11910.2 10572.6 10718.6 11051.8 11070.3 11090.6 9816.0 9870.6 9923.7 9954.0 10267.4 9391.8 9505.3 9565.2 9568.5 9688.3 13:07:29 INFO - PROCESS | 26566 | -------- Summary: end -------- 13:07:29 INFO - PROCESS | 26566 | 13:07:29 INFO - TEST-INFO | 26566: exit 0 13:07:29 INFO - TEST-OK | dromaeo_css | took 1115784ms 13:07:29 INFO - TEST-START | kraken 13:07:29 INFO - operating with platform_type : linux_ 13:07:29 INFO - Initialising browser for kraken test... 13:07:29 INFO - TEST-INFO | started process 26801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplx0Nw_/profile http://localhost:51934/getInfo.html) 13:07:33 INFO - PROCESS | 26801 | 13:07:33 INFO - PROCESS | 26801 | (process:26868): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:07:34 INFO - PROCESS | 26801 | __metrics Screen width/height:1600/1200 13:07:34 INFO - PROCESS | 26801 | colorDepth:24 13:07:34 INFO - PROCESS | 26801 | Browser inner width/height: 1024/697 13:07:34 INFO - PROCESS | 26801 | __metrics 13:07:35 ERROR - PROCESS | 26801 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:07:35 INFO - TEST-INFO | 26801: exit 0 13:07:35 INFO - Browser initialized. 13:07:35 INFO - Running cycle 1/1 for kraken test... 13:07:35 INFO - TEST-INFO | started process 26919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplx0Nw_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:37 INFO - PROCESS | 26919 | 13:07:37 INFO - PROCESS | 26919 | (process:26979): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:07:47 INFO - PROCESS | 26919 | RSS: Main: 165564416 13:07:47 INFO - PROCESS | 26919 | 13:07:50 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51934/tests/kraken/driver.html?testName=audio-beat-detection) 13:07:51 INFO - PROCESS | 26919 | RSS: Main: 169979904 13:07:51 INFO - PROCESS | 26919 | 13:07:54 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51934/tests/kraken/driver.html?testName=audio-dft) 13:07:55 INFO - PROCESS | 26919 | RSS: Main: 173412352 13:07:55 INFO - PROCESS | 26919 | 13:07:57 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51934/tests/kraken/driver.html?testName=audio-fft) 13:07:58 INFO - PROCESS | 26919 | RSS: Main: 164683776 13:07:58 INFO - PROCESS | 26919 | 13:08:00 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51934/tests/kraken/driver.html?testName=audio-oscillator) 13:08:01 INFO - PROCESS | 26919 | RSS: Main: 165310464 13:08:01 INFO - PROCESS | 26919 | 13:08:03 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51934/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:04 INFO - PROCESS | 26919 | RSS: Main: 166436864 13:08:04 INFO - PROCESS | 26919 | 13:08:07 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51934/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:08 INFO - PROCESS | 26919 | RSS: Main: 165900288 13:08:08 INFO - PROCESS | 26919 | 13:08:11 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51934/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:12 INFO - PROCESS | 26919 | RSS: Main: 165490688 13:08:12 INFO - PROCESS | 26919 | 13:08:15 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51934/tests/kraken/driver.html?testName=json-parse-financial) 13:08:15 INFO - PROCESS | 26919 | RSS: Main: 166072320 13:08:15 INFO - PROCESS | 26919 | 13:08:17 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51934/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:18 INFO - PROCESS | 26919 | RSS: Main: 166432768 13:08:18 INFO - PROCESS | 26919 | 13:08:19 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:20 INFO - PROCESS | 26919 | RSS: Main: 166191104 13:08:20 INFO - PROCESS | 26919 | 13:08:22 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:23 INFO - PROCESS | 26919 | RSS: Main: 166526976 13:08:23 INFO - PROCESS | 26919 | 13:08:26 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:26 INFO - PROCESS | 26919 | RSS: Main: 167538688 13:08:26 INFO - PROCESS | 26919 | 13:08:29 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:30 INFO - PROCESS | 26919 | RSS: Main: 167264256 13:08:30 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | Cycle 1(1): loaded http://localhost:51934/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51934/tests/kraken/driver.html?testName=ai-astar) 13:08:32 INFO - PROCESS | 26919 | RSS: Main: 168374272 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | __start_tp_report 13:08:32 INFO - PROCESS | 26919 | _x_x_mozilla_page_load 13:08:32 INFO - PROCESS | 26919 | _x_x_mozilla_page_load_details 13:08:32 INFO - PROCESS | 26919 | |i|pagename|runs| 13:08:32 INFO - PROCESS | 26919 | |0;ai-astar;116;112;114;117;115;127;115;114;115;113 13:08:32 INFO - PROCESS | 26919 | |1;audio-beat-detection;165;136;161;197;137;157;160;138;179;134 13:08:32 INFO - PROCESS | 26919 | |2;audio-dft;164;162;165;176;165;163;165;163;167;163 13:08:32 INFO - PROCESS | 26919 | |3;audio-fft;76;74;75;164;75;74;76;73;155;77 13:08:32 INFO - PROCESS | 26919 | |4;audio-oscillator;95;95;143;95;96;94;148;95;95;135 13:08:32 INFO - PROCESS | 26919 | |5;imaging-gaussian-blur;117;117;122;117;118;118;118;118;118;118 13:08:32 INFO - PROCESS | 26919 | |6;imaging-darkroom;147;148;147;148;146;146;147;148;147;146 13:08:32 INFO - PROCESS | 26919 | |7;imaging-desaturate;97;96;96;96;96;96;95;97;96;96 13:08:32 INFO - PROCESS | 26919 | |8;json-parse-financial;72;68;68;67;69;68;66;82;65;66 13:08:32 INFO - PROCESS | 26919 | |9;json-stringify-tinderbox;67;68;65;65;65;64;64;66;67;65 13:08:32 INFO - PROCESS | 26919 | |10;stanford-crypto-aes;87;81;80;80;81;80;80;81;82;80 13:08:32 INFO - PROCESS | 26919 | |11;stanford-crypto-ccm;136;132;135;143;141;131;140;138;167;144 13:08:32 INFO - PROCESS | 26919 | |12;stanford-crypto-pbkdf2;172;173;175;178;174;168;182;171;174;181 13:08:32 INFO - PROCESS | 26919 | |13;stanford-crypto-sha256-iterative;73;73;72;73;73;79;71;70;71;73 13:08:32 INFO - PROCESS | 26919 | __end_tp_report 13:08:32 INFO - PROCESS | 26919 | __start_cc_report 13:08:32 INFO - PROCESS | 26919 | _x_x_mozilla_cycle_collect,924 13:08:32 INFO - PROCESS | 26919 | __end_cc_report 13:08:32 INFO - PROCESS | 26919 | __startTimestamp1461528512473__endTimestamp 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | ------- Summary: start ------- 13:08:32 INFO - PROCESS | 26919 | Number of tests: 14 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.18 (3.6%) stddev-sans-first:4.44 13:08:32 INFO - PROCESS | 26919 | Values: 116.0 112.0 114.0 117.0 115.0 127.0 115.0 114.0 115.0 113.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:160.50 stddev:20.82 (13.0%) stddev-sans-first:21.85 13:08:32 INFO - PROCESS | 26919 | Values: 165.0 136.0 161.0 197.0 137.0 157.0 160.0 138.0 179.0 134.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:4.03 (2.4%) stddev-sans-first:4.25 13:08:32 INFO - PROCESS | 26919 | Values: 164.0 162.0 165.0 176.0 165.0 163.0 165.0 163.0 167.0 163.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:35.71 (47.6%) stddev-sans-first:37.41 13:08:32 INFO - PROCESS | 26919 | Values: 76.0 74.0 75.0 164.0 75.0 74.0 76.0 73.0 155.0 77.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.00 stddev:22.92 (24.1%) stddev-sans-first:23.73 13:08:32 INFO - PROCESS | 26919 | Values: 95.0 95.0 143.0 95.0 96.0 94.0 148.0 95.0 95.0 135.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.45 (1.2%) stddev-sans-first:1.48 13:08:32 INFO - PROCESS | 26919 | Values: 117.0 117.0 122.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 13:08:32 INFO - PROCESS | 26919 | Values: 147.0 148.0 147.0 148.0 146.0 146.0 147.0 148.0 147.0 146.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 13:08:32 INFO - PROCESS | 26919 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:68.00 stddev:4.93 (7.3%) stddev-sans-first:5.12 13:08:32 INFO - PROCESS | 26919 | Values: 72.0 68.0 68.0 67.0 69.0 68.0 66.0 82.0 65.0 66.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:1.35 (2.1%) stddev-sans-first:1.33 13:08:32 INFO - PROCESS | 26919 | Values: 67.0 68.0 65.0 65.0 65.0 64.0 64.0 66.0 67.0 65.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.15 (2.7%) stddev-sans-first:0.73 13:08:32 INFO - PROCESS | 26919 | Values: 87.0 81.0 80.0 80.0 81.0 80.0 80.0 81.0 82.0 80.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:140.50 stddev:10.22 (7.3%) stddev-sans-first:10.70 13:08:32 INFO - PROCESS | 26919 | Values: 136.0 132.0 135.0 143.0 141.0 131.0 140.0 138.0 167.0 144.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:174.50 stddev:4.39 (2.5%) stddev-sans-first:4.54 13:08:32 INFO - PROCESS | 26919 | Values: 172.0 173.0 175.0 178.0 174.0 168.0 182.0 171.0 174.0 181.0 13:08:32 INFO - PROCESS | 26919 | 13:08:32 INFO - PROCESS | 26919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:2.44 (3.3%) stddev-sans-first:2.59 13:08:32 INFO - PROCESS | 26919 | Values: 73.0 73.0 72.0 73.0 73.0 79.0 71.0 70.0 71.0 73.0 13:08:32 INFO - PROCESS | 26919 | -------- Summary: end -------- 13:08:32 INFO - PROCESS | 26919 | 13:08:33 INFO - TEST-INFO | 26919: exit 0 13:08:33 INFO - TEST-OK | kraken | took 63635ms 13:08:33 INFO - SUITE-END | took 1179s 13:08:33 INFO - Completed test suite (00:19:39) 13:08:33 INFO - javascript benchmark 13:08:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.921162365129, 2663.9866800666, 2700.4194098268867, 2707.309636042809, 2711.159540542433, 4736.786844591998, 4761.71429714217, 4765.761711914408, 4780.784864681089, 4839.201531747258, 4705.83529576464, 4766.976165119169, 4814.277858321254, 4852.927206091903, 4887.242477415997, 4443.289073748201, 4487.147441986012, 4538.682292239545, 4540.59134677879, 4587.0137920347115, 4453.421055262811, 4530.343100250462, 4544.681872268926, 4549.067441174568, 4573.291139873325, 4313.568643135693, 4326.6538676905775, 4392.516823149451, 4471.172833025885, 4508.098380323949, 4432.401625780511, 4461.754603496806, 4467.195904737146, 4468.5531446855375, 4501.212287849613, 4404.273294906337, 4426.62373698236, 4436.534163912807, 4436.55634436557, 4462.486814016397, 4669.089527542131, 4729.834455794065, 4746.264329029006, 4761.904761904777, 4787.640926930494, 5079.187330027215, 5117.897642047175, 5133.743312834344, 5137.537621614073, 5167.534921857014, 5107.897842043139, 5136.049830781318, 5179.507946745053, 5182.507661772125, 5187.792488300463, 4825.710457372498, 4838.322634831126, 4844.031193761261, 4851.733154676526, 4904.43598986114, 5251.343582052244, 5320.547753440924, 5327.174287985368, 5339.41266460689, 5364.839054828361, 4988.226824842155, 5086.3896332440345, 5086.491350864884, 5113.181890897438, 5172.172452407597, 5148.510891465305, 5171.0, 5173.32746742921, 5174.948250517522, 5214.921776173361, 5065.062963351792, 5094.821681241138, 5191.143461328838, 5223.0, 5240.3973543042275, 4968.378952630921, 5052.8484145475695, 5101.311322971425, 5106.591472682177, 5107.514786095315, 4379.3430985351815, 4381.0, 4386.122775444924, 4419.889502762457, 4425.5574442556135, 3796.848126074926, 3816.580176180618, 3834.5973672764517, 3855.614438556122, 3898.2788184186015, 4325.52419233884, 4375.4968178659865, 4382.517923028464, 4413.183561041217, 4485.708428952108, 5188.63679542436, 5194.558462530727, 5210.088234558937, 5239.738013099406, 5247.134222853187, 4465.12929978651, 4465.955340446619, 4466.106778644219, 4485.304777759453, 4511.684182107287, 4545.36364908913, 4610.354550362952, 4662.114198302312, 4682.993156471375, 4687.0, 4755.358026666425, 4770.594499467584, 4817.445993710769, 4823.662343635911, 4828.927566086511, 5109.105906466428, 5126.231065340229, 5129.487051294841, 5132.358455193101, 5148.639595228298, 4763.1426343258545, 4847.854564363075, 4891.144049791344, 4922.926156107733, 4935.531124543163, 5072.847814565569, 5087.389513258433, 5102.566281866083, 5102.923456148235, 5155.02054609623, 5047.444781074006, 5154.407243167084, 5177.922331165111, 5193.818216362561, 5211.4527974562125, 4918.163912134874, 5000.949990500048, 5025.120603894231, 5094.337736094284, 5138.4604616514725, 4922.8769280768265, 4932.753362331798, 4952.4057113146655, 4956.10790057793, 5019.0965626187635, 4750.643701722453, 4856.611471082376, 4868.14807408695, 4904.485029072039, 4934.037862616899, 4921.26181072842, 5020.523050310215, 5070.087384270867, 5087.287779710769, 5109.616778741535, 4987.675801072919, 5001.374828146481, 5019.171836647059, 5036.320096786887, 5074.035933172685], "value": 4733.793129682752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.7686213945492, 603.420716112532, 617.2747022248857, 624.6314674342138, 649.5193556767994, 35193.64806351936, 36431.63568364316, 36438.635613643855, 36441.817790911075, 36645.0, 38416.0, 39323.41014884772, 39488.605113948855, 39514.8024259879, 39591.40612890809, 7623.313901748827, 7843.529388236724, 7845.333146682538, 7867.213278672144, 7875.724349647735, 7594.582297973637, 7714.922850771504, 7757.224277572254, 7759.495632783879, 7765.378769698439, 7729.574873381962, 7779.0, 7780.49426787257, 7783.88324175135, 7793.961030194841, 7718.266764657348, 7759.612019399007, 7771.145174030852, 7773.611319434006, 7786.0, 7447.553146811155, 7597.088349398053, 7618.085829700416, 7663.501872378278, 7665.965094712254, 29831.403371932658, 35908.28183436343, 36616.45075323872, 36652.450213246826, 36781.816090919376, 3055.2972816252163, 3083.383323335342, 3200.7439404847555, 3211.4058899103507, 3250.6749325067303, 27513.0, 29612.555811662627, 29887.0, 30109.849450752827, 30730.385392292254, 3208.4545627243424, 3290.7367410607094, 3306.206510437502, 3339.782914110575, 3427.725781937439, 244669.0, 326330.0, 337985.3100734505, 338249.0, 338348.0, 51767.48232517702, 52013.7399313001, 52210.477895221324, 52245.0, 52375.73812130915, 55615.0, 64015.679921600095, 64998.0, 65724.67137664281, 65974.0, 13815.723685526233, 13900.235487048107, 14024.439022439192, 14059.0, 14207.64480887986, 10844.403557804397, 10914.126869850394, 10956.178286628534, 10976.451177441255, 11017.889821101846, 18720.719189212174, 18769.53076173079, 18821.811781882006, 18828.341008064654, 19842.70235946462, 7470.514416562906, 7586.5448073114685, 7683.884741728767, 7744.0, 7856.685732570748, 916.8303863785221, 943.4480828715141, 1002.3785253142952, 1019.4189312092036, 1029.2332212501733, 28515.714842851306, 28554.428911421655, 29070.418591628473, 29388.265293367836, 29418.411631767245, 961.7259081161835, 1026.0201507560262, 1081.0540776820283, 1085.9945700271448, 1098.5056724474018, 14889.553313400615, 15465.845341546665, 15477.0, 15650.530484085495, 15725.528234152993, 367138.0, 374095.0, 375297.0, 375989.0, 378141.0, 49011.0, 49443.50556494389, 49609.0, 50038.749806251464, 50048.0, 1218.8842060004463, 1257.1074537078775, 1265.4115836136057, 1265.829113069742, 1275.5726831511547, 27031.45937081208, 28277.15168544947, 28398.0, 28458.57312140361, 28718.856405717837, 41300.58699412968, 41361.79319103385, 41605.1678966425, 41862.372064419666, 41994.58005420029, 308554.0, 309820.0, 312725.0, 312734.0, 313927.0, 26333.473330533667, 26870.865645671645, 41538.37692434555, 42618.0, 42830.0, 41464.1707165861, 41524.58475415328, 41552.79223603863, 42168.36747448852, 42629.5737042638, 34995.300093997466, 35923.0, 36157.81921090378, 36248.637513624526, 36629.450558241115, 34857.0, 35061.29877402489, 35080.82459587686, 35391.82304088463, 35419.29161416706, 31097.689023110383, 35392.29215415729, 35716.28567428585, 37709.622903770614, 37846.43230351492, 28625.713742862306, 29155.562666559596, 29471.55792663069, 29673.406531869674, 29782.255443613216, 23388.298351049496, 25104.874475627505, 25157.748422515542, 25177.74822251754, 25381.619275711248], "value": 17875.334330314254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.8565359509791, 370.32785494327794, 370.4665281993928, 381.0397797550174, 387.0073262082759, 15588.844111558881, 15668.451604193855, 16375.0, 16426.917865410673, 16483.0, 15819.525414237563, 16488.917555412205, 17232.138393080328, 17247.82752172478, 17318.48044558662, 5169.612279079065, 5279.604029697788, 5332.066888294552, 5344.251804747319, 5346.946530534703, 3744.475773391727, 5216.113260745663, 5830.09633506805, 6168.691565421734, 6177.042558403455, 6053.303870054934, 6066.939330606681, 6091.116788065728, 6099.390060993909, 6105.0, 5092.134337162691, 5338.492843179892, 5365.114756065244, 5382.2464854920345, 5394.676319420828, 5003.649744517885, 5208.427073021964, 5400.621956463049, 5433.831726178851, 5435.211894275308, 10965.50655220509, 11715.53137874484, 11722.94138529302, 11800.173987820855, 11817.290962542274, 1835.220031486626, 1857.7863545692283, 1874.6157037807218, 1948.1915005272795, 2032.867863588862, 8995.730128096167, 9149.130832570896, 9584.568694408768, 11813.822792658117, 12962.861182866056, 1724.767156433878, 1750.2124044180043, 1754.7192449208194, 1755.9209835557303, 1794.1836464408664, 68814.0, 70237.0, 71229.28770712278, 71447.64276178586, 71479.28520714778, 10124.13944814699, 10130.696079117639, 10185.898141018642, 10272.948635256926, 10284.948575257076, 14053.297335133202, 14095.436182552789, 14148.646283842987, 14237.928810355881, 14291.42834286617, 6786.626735529495, 7178.533395329287, 7293.307135822089, 7398.630068496554, 7406.333429991327, 6687.963365678328, 6711.161104861892, 6780.186377634715, 6875.7937261882225, 6906.516543841984, 4363.192809330284, 4437.378766972626, 4438.156750217513, 4477.597016268552, 4493.056458143827, 1724.9137543122793, 1765.796933352681, 1835.9443320091002, 1878.8872667639985, 1885.820847019531, 864.4985908173245, 875.746033650247, 944.4569372610639, 962.855571664242, 971.2472833554052, 15204.16377099248, 15838.287277072559, 16385.0, 16393.42623008189, 16728.330866765195, 842.2672275120561, 854.4147259127518, 860.1742327365674, 864.9740507784777, 901.6078006067381, 8262.628181731836, 9270.258379329638, 9327.766805829773, 9357.344985850925, 9504.857427138599, 283895.0, 290474.0, 292570.0, 393077.0, 393098.0, 78982.21017789864, 81840.59079704683, 82806.0, 84848.57575712082, 85242.57378713066, 956.8038552096804, 964.7298756348234, 999.7650552120245, 1000.3097862474724, 1002.4236064263077, 14995.250237487864, 15082.24588770535, 15111.319990600668, 15125.470608528649, 15541.45604903823, 32945.505817412275, 33188.668113318556, 33490.49764253587, 33633.15917102092, 34413.0, 41885.37171942362, 46378.536214637425, 46821.29768053414, 47432.2885156716, 47701.950208504175, 4771.6898401603785, 4774.069056534081, 6977.860442791014, 7901.684749579126, 7935.920640793749, 8373.413861029669, 9925.801483970425, 10324.896751032393, 10995.395253261147, 11077.390743509184, 9290.0, 9375.624975001196, 9379.296552758708, 9456.810863782823, 10013.699589012342, 9248.907510925073, 9269.768255793659, 9653.0, 9659.0, 9954.900450995687, 9240.907590924005, 9431.669891554036, 9495.445339080386, 9558.23534117255, 10061.547230374505, 7644.273793989784, 7693.88459173124, 7707.0, 7714.459987801025, 7903.288704016666, 9204.493752843659, 9574.186194173573, 9596.856047159159, 9607.0, 9922.751931201488], "value": 7951.221873075313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.653283212029, 1457.4825936792438, 1595.920203989801, 1679.6640671865614, 1811.4384540792348, 6968.303169683029, 7178.174509931359, 7465.328120469164, 7472.589007604586, 7592.506487078336, 7614.4669873108905, 7684.577348245858, 7769.883451748228, 7781.105172905118, 7797.0, 2191.0468946008496, 2242.1479837661664, 2255.6052690779047, 2261.118163916074, 2262.049939025613, 2180.1388451561625, 2207.7129973103474, 2227.9665805012937, 2228.576570451609, 2234.754177040524, 2166.5450255446376, 2204.0742887987085, 2204.5370472200857, 2220.578090162864, 2242.4842286274165, 2122.2198919415614, 2132.509522809755, 2141.582391433671, 2147.9355619331445, 2152.655575107975, 2155.5150091229507, 2161.5136594266164, 2166.1876796201423, 2180.760116387196, 2182.443476913377, 7969.920300797034, 7996.200379962015, 8002.239787220205, 8025.719099831478, 8035.5580443075605, 4679.9298010529865, 4838.516148385133, 4851.975740121276, 4859.684120532154, 4866.197077482211, 2995.925101872449, 3002.579638850563, 3019.5168772996435, 3046.4973279408873, 3126.5622812806228, 939.3002213351028, 950.6102497975866, 961.889382720989, 964.5370222293268, 967.4050458967755, 10544.525496352682, 10769.246152769309, 10794.892051079467, 10809.945950270197, 10835.458227088615, 4295.935560966588, 4310.396544483775, 4489.349044388546, 4497.392851965008, 4538.704984176018, 9244.722658320261, 9298.53507324631, 9316.068393160765, 9335.90664093364, 9361.531923403803, 4817.301491283744, 4839.395075615548, 4855.44162421319, 4860.052289803454, 4863.489333619989, 3773.6792372648633, 4116.958830411718, 4233.661307095425, 4356.237658409766, 4420.977895110504, 3730.645588669072, 3817.2938006468894, 3831.425286207091, 3862.362710152793, 3865.594112618191, 1239.6157191270554, 1283.890869276122, 1293.224065560656, 1293.9935300323439, 1294.8122522234223, 818.145038434837, 845.8435189489965, 867.7353407210861, 875.470340444035, 885.3404213860715, 5358.169483730028, 5530.391656917735, 5531.308586426697, 5594.524465420485, 5746.0, 416.4149370134965, 436.79907242668094, 440.5110327536432, 441.4570078803026, 449.3103086761805, 3659.396199627085, 3705.2589482103685, 3710.703143748494, 3797.6771974381936, 3832.3868181090893, 9373.578188981512, 9711.27165462593, 9734.464604446823, 9798.853017204749, 9816.165625921876, 9660.32377733552, 9666.806663866684, 9698.127168554724, 9724.027597240362, 9728.221742260603, 7052.576845389293, 7270.781876543712, 7386.630668466662, 7401.703931842773, 7414.221506741822, 5269.78920843162, 5300.867478313073, 5372.865678358073, 5375.543078838186, 5437.238786569963, 8822.426542274732, 8864.246539043996, 8914.197722205032, 8944.239739622206, 8956.238719708897, 8669.869951950599, 9117.225035872025, 9178.357514974155, 9209.355345125778, 9226.215771659485, 6203.565750397609, 6395.616263024233, 6651.135352404156, 6937.9653101736185, 7000.809862323315, 7396.519226250277, 7414.480986330905, 7467.066616672916, 7501.774946751606, 7501.849963000818, 6529.314421985623, 6663.300353462817, 6731.865362692816, 6746.595204287759, 6805.081314022742, 6506.544541882212, 6551.344865513411, 6568.770093046721, 6593.868122637617, 6704.664766761545, 6249.312575616769, 6308.463780578702, 6340.524460665376, 6417.2299324081405, 6425.357464253537, 4700.882477938079, 4863.294822250825, 4932.457429682804, 5006.123928312458, 5007.1487847065355, 4839.467658557485, 4858.319835223142, 4965.503449655005, 4999.875003124951, 5012.0], "value": 4149.408167715785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7210096963218, 316.1653235458389, 317.2734438136667, 318.69405370844004, 327.395954464014, 5386.814900721844, 5449.56403487721, 5460.590455715817, 5480.945190548094, 5492.588055895809, 5350.785968561253, 5365.436629153941, 5367.597430192742, 5371.435999220084, 5382.784688612461, 3960.2871483133026, 4028.5971402859773, 4157.916841663165, 4164.875053748392, 4173.9582604173875, 4153.41852140699, 4164.0630858057, 4164.354525048622, 4177.394277829713, 4178.895527611804, 4153.293940030202, 4154.688398370119, 4157.3393028461805, 4163.7293575917465, 4175.123224122923, 4005.339119045354, 4120.278951183561, 4152.148809494047, 4152.979235103835, 4155.065110350177, 3603.549556305462, 3621.5835178954494, 3628.727845411605, 3630.5280313559333, 3642.5993140754495, 5089.0, 5099.770510327045, 5133.28134061228, 5133.768980395891, 5145.253938178943, 4434.623057040156, 4681.953180468186, 4792.113459010059, 4804.879878003043, 4817.951820481785, 5609.49514543693, 5660.745266463019, 5663.66018038919, 5666.150077488369, 5701.71491425427, 3882.0877093882914, 3887.8250478728523, 3906.7069969752383, 3918.1380096378753, 3923.5487918889407, 5844.590878638497, 5898.41015898411, 5908.615939963888, 5937.376575459601, 6004.639721616717, 3897.376419772879, 3913.7847418391693, 3919.9216015679526, 3929.174873276587, 3938.86213982515, 3969.2656858481273, 3974.4833171687496, 3983.462232598562, 3990.4014397839974, 4003.459532963013, 4575.748333841604, 4662.743549104764, 4672.2057250267535, 4678.0410015946645, 4694.0, 5676.545876329884, 5697.145428185805, 5702.686352250583, 5704.743286552115, 5727.140928860705, 1397.9161250325012, 1416.8016477693131, 1416.971660566783, 1417.6455886028493, 1419.6096073579847, 872.7948932000975, 917.9495127768037, 922.3313098004028, 944.0, 954.3510412919281, 4804.399450068741, 4807.351007613997, 4808.206645903387, 4819.759012049383, 4822.180229361017, 5746.396628354046, 5747.339056008613, 5752.9424705753245, 5803.303603567599, 5819.359870414251, 4691.413573303337, 4833.854984350475, 4852.743474284474, 4855.247436647325, 4966.776495057731, 3131.7024882636115, 3165.8733650653717, 3170.0, 3174.2699179188917, 3174.873005079771, 5542.2795036644975, 5553.666779993213, 5559.27729395176, 5565.443455654483, 5565.554755619622, 5950.077737950624, 6057.151998720183, 6095.908561371494, 6125.479334256549, 6143.723532441051, 5518.172274158908, 5534.142207957773, 5559.555235581063, 5564.4991950724625, 5569.805056822992, 5684.317881854038, 5889.617174883619, 5889.646621202742, 5902.557308201816, 5903.409659034062, 5789.131630255495, 5814.680192589448, 5815.621984570989, 5819.243498345188, 5856.180134781049, 5554.361248456479, 5557.749901254534, 5558.0, 5568.470995255444, 5602.159676048625, 3787.14789172434, 3981.56202817684, 3989.800509974548, 4024.3762216856435, 4064.5122585289955, 5886.6173698709445, 5902.0, 5912.640092778599, 5933.258342707161, 5934.287885453773, 5590.636608620427, 5692.971535142297, 5714.942850571441, 5730.856728581819, 5784.334801497882, 5670.489655930986, 5689.630174038674, 5705.828825135252, 5713.400092990176, 5714.20001199824, 5311.893762124813, 5557.388687244319, 5562.249096371938, 5589.6366736163645, 5622.9718851407115, 5563.415841336601, 5736.210264429082, 5736.885262294814, 5739.598228124159, 5793.826185214451, 5585.553155747449, 5610.663360198401, 5614.915776263278, 5672.347680016685, 5683.8863222736145], "value": 4227.720225111572, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.9406447484201, 756.3117563017655, 769.1539306762562, 772.6909236305477, 776.0958483366878, 11381.374024428653, 11479.13906457017, 11496.310221386702, 11518.308901465918, 12026.819597706042, 12170.269783812977, 12216.81674774877, 13365.264910429922, 13779.44882204713, 13790.517331893385, 826.1531929771987, 836.8200836820082, 837.0248660310731, 837.7779888329567, 838.9496630202208, 649.7888186339459, 813.4712436915993, 820.7906983719143, 821.2690705272282, 841.3269384492412, 872.6596627315321, 873.6461732998146, 875.9124087591254, 876.0626130040858, 877.5129802959354, 858.6307887608326, 865.212656482601, 865.7835541114721, 868.2663149638609, 868.9087645797226, 628.7045088808298, 629.2857606616477, 629.512128100721, 629.804760524239, 631.3307893632764, 13100.803487947689, 13226.735465290736, 13228.27244501552, 13242.139260948104, 13257.933710331483, 12410.689732756662, 12438.19151755133, 12471.251724896536, 12674.74650506994, 12911.741765164645, 10095.192384609214, 10147.188224941987, 10197.898021019842, 10225.38647681134, 10257.43584102874, 3293.7035666790102, 3307.9173020674675, 3338.232206592473, 3342.1644588852787, 3439.724822014258, 47857.521424786006, 47983.28025079626, 48185.0, 48452.757736211446, 48842.26736598954, 9562.426254424758, 9680.903190968142, 9732.367396119229, 9763.755906102404, 9810.75473113178, 16471.83528164703, 16543.6691266174, 16569.42007029748, 16583.91708041476, 16584.585385365222, 6934.202566704793, 7027.402670772939, 7041.366277035091, 7129.322714342129, 7219.350258476762, 3880.5537363203593, 3981.6814654827544, 3982.1040265939932, 4031.07285324377, 4039.071013666873, 2823.68939416664, 2882.524383476745, 2896.4786338458857, 2896.6089577907132, 2901.448724742292, 505.43391401629674, 509.7333127178957, 512.8640910158811, 513.6430181024152, 515.6416290677943, 553.3636318233982, 556.349071586245, 601.9247594050744, 616.2174038970483, 669.9832504187336, 7589.620518974029, 7982.401319901031, 8133.674653013932, 8141.185881411811, 8256.463329883538, 509.20818127811606, 526.3420226287226, 606.2603623579226, 627.5450298533526, 655.9048937904073, 3766.6798322142376, 3971.72197946141, 3988.1026768977326, 4083.372574289302, 4146.398772178018, 52903.0, 52950.0, 53025.73487132617, 53153.46846531485, 53446.46553534415, 40171.59828401737, 45260.0, 45293.54706452959, 46025.079498410516, 46641.0, 36982.815085924936, 39017.219655607296, 40213.39679904804, 40394.79802601027, 41582.79208603998, 8120.715774947848, 8220.219079187467, 8435.156484351515, 8566.18621230982, 8624.353173512138, 25847.483050339262, 26087.478250435266, 26907.192784216506, 26924.730752692223, 26938.730612693624, 34247.486287706204, 36768.44847327239, 38076.428853566664, 38533.42199866948, 38843.80578097091, 10559.683209503728, 10582.894171058191, 10674.46627668598, 10677.9466102669, 10840.512176952214, 11743.76512469763, 11826.46780894879, 11868.821967670665, 11879.10906681985, 12036.578719745117, 10157.84763228567, 11083.944580277048, 11131.387773672526, 11332.660020199408, 11546.863830191442, 10995.395253261147, 11025.944870275598, 11485.655430337103, 11505.712357190803, 11910.225835320676, 10572.629957951434, 10718.571257149626, 11051.834222486508, 11070.335779853234, 11090.611828586283, 9816.0, 9870.555824987749, 9923.702288931343, 9954.0, 10267.435291058764, 9391.765205869908, 9505.334626576074, 9565.204358447843, 9568.4737339447, 9688.32181747271], "value": 5989.41863402766, "unit": "score"}], "name": "dromaeo_css", "value": 6430.379696280885, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 114.0, 117.0, 115.0, 127.0, 115.0, 114.0, 115.0, 113.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 136.0, 161.0, 197.0, 137.0, 157.0, 160.0, 138.0, 179.0, 134.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 176.0, 165.0, 163.0, 165.0, 163.0, 167.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 164.0, 75.0, 74.0, 76.0, 73.0, 155.0, 77.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 143.0, 95.0, 96.0, 94.0, 148.0, 95.0, 95.0, 135.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 122.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 67.0, 69.0, 68.0, 66.0, 82.0, 65.0, 66.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 65.0, 65.0, 64.0, 64.0, 66.0, 67.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 80.0, 80.0, 81.0, 80.0, 80.0, 81.0, 82.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 135.0, 143.0, 141.0, 131.0, 140.0, 138.0, 167.0, 144.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 175.0, 178.0, 174.0, 168.0, 182.0, 171.0, 174.0, 181.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 73.0, 79.0, 71.0, 70.0, 71.0, 73.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1603.8999999999999, "alertThreshold": 2.0}]} 13:08:33 INFO - Return code: 0 13:08:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:08:33 ERROR - # TBPL SUCCESS # 13:08:33 INFO - Running post-action listener: _resource_record_post_action 13:08:33 INFO - Running post-run listener: _resource_record_post_run 13:08:34 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518414336; Read time: 12; Write time: 515928 13:08:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234557440; Read time: 0; Write time: 301004 13:08:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283856896; Read time: 12; Write time: 214924 13:08:34 INFO - Running post-run listener: _upload_blobber_files 13:08:34 INFO - Blob upload gear active. 13:08:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:34 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 13:08:34 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'] 13:08:34 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 13:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:36 INFO - (blobuploader) - INFO - Done attempting. 13:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:36 INFO - (blobuploader) - INFO - Done attempting. 13:08:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:36 INFO - Return code: 0 13:08:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7011818cdc31fcd717401815b562564b34c58664a722379b166b243ab24ab0e971fe9df8f84a6238f76bb47143d06ac48219218fdf557528bb7a6b607db306c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c08bbfa848a1dcf5fb4c9c9321201f98f95dd6e40ae86e6eb4a954549d536c0173dd4d0f54c8d5c0288e06fd76de3896e2d7beda41f4d8b3b37ac7b996fab8"} 13:08:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:36 INFO - Contents: 13:08:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c7011818cdc31fcd717401815b562564b34c58664a722379b166b243ab24ab0e971fe9df8f84a6238f76bb47143d06ac48219218fdf557528bb7a6b607db306c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c08bbfa848a1dcf5fb4c9c9321201f98f95dd6e40ae86e6eb4a954549d536c0173dd4d0f54c8d5c0288e06fd76de3896e2d7beda41f4d8b3b37ac7b996fab8"} 13:08:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:36 INFO - Copying logs to upload dir... 13:08:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.314791 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-24 13:08:34.740201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 13:08:34.745185) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846 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/c7011818cdc31fcd717401815b562564b34c58664a722379b166b243ab24ab0e971fe9df8f84a6238f76bb47143d06ac48219218fdf557528bb7a6b607db306c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c08bbfa848a1dcf5fb4c9c9321201f98f95dd6e40ae86e6eb4a954549d536c0173dd4d0f54c8d5c0288e06fd76de3896e2d7beda41f4d8b3b37ac7b996fab8"} build_url:https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/GpMZjFiGTNye4LNz6vzmQg/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/c7011818cdc31fcd717401815b562564b34c58664a722379b166b243ab24ab0e971fe9df8f84a6238f76bb47143d06ac48219218fdf557528bb7a6b607db306c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61c08bbfa848a1dcf5fb4c9c9321201f98f95dd6e40ae86e6eb4a954549d536c0173dd4d0f54c8d5c0288e06fd76de3896e2d7beda41f4d8b3b37ac7b996fab8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 13:08:34.772732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:08:34.773085) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461526664.210113-145912846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:08:35.066251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 13:08:35.066631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 13:08:35.067009) ========= ========= Total master_lag: 0.87 =========