builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1461789453.13 results: success (0) buildid: 20160427132147 builduid: af8cbe5b872147b9854b3a133c36c2eb revision: f1ff46a78fa5f30b208b33269b48ba4ba367b34f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.131915) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.132675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.132941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.185837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.186120) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 13:37:33-- 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% 227M=0s 2016-04-27 13:37:33 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.347551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.347842) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.266799 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.626191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:33.626508) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1ff46a78fa5f30b208b33269b48ba4ba367b34f --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 f1ff46a78fa5f30b208b33269b48ba4ba367b34f --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=7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 13:37:33,698 truncating revision to first 12 chars 2016-04-27 13:37:33,698 Setting DEBUG logging. 2016-04-27 13:37:33,698 attempt 1/10 2016-04-27 13:37:33,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1ff46a78fa5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 13:37:33,965 unpacking tar archive at: fx-team-f1ff46a78fa5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539864 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:34.178080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:34.178376) ========= script_repo_revision: f1ff46a78fa5f30b208b33269b48ba4ba367b34f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:34.178765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:34.179084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 13:37:34.186273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-04-27 13:37:34.186530) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:37:34 INFO - MultiFileLogger online at 20160427 13:37:34 in /builds/slave/test 13:37:34 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 13:37:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:37:34 INFO - {'append_to_log': False, 13:37:34 INFO - 'base_work_dir': '/builds/slave/test', 13:37:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:37:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:37:34 INFO - 'branch': 'Fx-Team-Non-PGO', 13:37:34 INFO - 'buildbot_json_path': 'buildprops.json', 13:37:34 INFO - 'config_files': ('talos/linux_config.py',), 13:37:34 INFO - 'default_actions': ('clobber', 13:37:34 INFO - 'read-buildbot-config', 13:37:34 INFO - 'download-and-extract', 13:37:34 INFO - 'populate-webroot', 13:37:34 INFO - 'create-virtualenv', 13:37:34 INFO - 'install', 13:37:34 INFO - 'run-tests'), 13:37:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:37:34 INFO - 'download_minidump_stackwalk': True, 13:37:34 INFO - 'download_symbols': 'ondemand', 13:37:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:37:34 INFO - 'tooltool.py': '/tools/tooltool.py', 13:37:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:37:34 INFO - '/tools/misc-python/virtualenv.py')}, 13:37:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:37:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:37:34 INFO - 'installer_path': 'installer.exe', 13:37:34 INFO - 'log_level': 'info', 13:37:34 INFO - 'log_name': 'talos', 13:37:34 INFO - 'log_to_console': True, 13:37:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:37:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:37:34 INFO - 'opt_config_files': (), 13:37:34 INFO - 'pip_index': False, 13:37:34 INFO - 'sps_profile': False, 13:37:34 INFO - 'sps_profile_interval': 0, 13:37:34 INFO - 'suite': 'dromaeojs-e10s', 13:37:34 INFO - 'system_bits': '32', 13:37:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:37:34 INFO - 'title': 'talos-linux64-ix-005', 13:37:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:37:34 INFO - 'use_talos_json': True, 13:37:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:37:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:37:34 INFO - 'work_dir': 'build'} 13:37:34 INFO - ##### 13:37:34 INFO - ##### Running clobber step. 13:37:34 INFO - ##### 13:37:34 INFO - Running pre-action listener: _resource_record_pre_action 13:37:34 INFO - Running main action method: clobber 13:37:34 INFO - rmtree: /builds/slave/test/build 13:37:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:37:36 INFO - Running post-action listener: _resource_record_post_action 13:37:36 INFO - ##### 13:37:36 INFO - ##### Running read-buildbot-config step. 13:37:36 INFO - ##### 13:37:36 INFO - Running pre-action listener: _resource_record_pre_action 13:37:36 INFO - Running main action method: read_buildbot_config 13:37:36 INFO - Using buildbot properties: 13:37:36 INFO - { 13:37:36 INFO - "project": "", 13:37:36 INFO - "product": "firefox", 13:37:36 INFO - "script_repo_revision": "production", 13:37:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:37:36 INFO - "repository": "", 13:37:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:37:36 INFO - "buildid": "20160427132147", 13:37:36 INFO - "pgo_build": "False", 13:37:36 INFO - "basedir": "/builds/slave/test", 13:37:36 INFO - "buildnumber": 1226, 13:37:36 INFO - "slavename": "talos-linux64-ix-005", 13:37:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:37:36 INFO - "platform": "ubuntu64_hw", 13:37:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:37:36 INFO - "branch": "fx-team", 13:37:36 INFO - "repo_path": "integration/fx-team", 13:37:36 INFO - "revision": "f1ff46a78fa5f30b208b33269b48ba4ba367b34f", 13:37:36 INFO - "stage_platform": "linux64", 13:37:36 INFO - "builduid": "af8cbe5b872147b9854b3a133c36c2eb", 13:37:36 INFO - "slavebuilddir": "test" 13:37:36 INFO - } 13:37:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:37:36 INFO - Running post-action listener: _resource_record_post_action 13:37:36 INFO - ##### 13:37:36 INFO - ##### Running download-and-extract step. 13:37:36 INFO - ##### 13:37:36 INFO - Running pre-action listener: _resource_record_pre_action 13:37:36 INFO - Running main action method: download_and_extract 13:37:36 INFO - mkdir: /builds/slave/test/build/tests 13:37:36 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')]} 13:37:36 INFO - https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:37:40 INFO - Downloaded 1361 bytes. 13:37:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:37:40 INFO - Using the following test package requirements: 13:37:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:37:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:37:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:37:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'jsshell-linux-x86_64.zip'], 13:37:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:37:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:37:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:37:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:37:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:37:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:37:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:37:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:37:40 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')]} 13:37:40 INFO - https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:38:48 INFO - Downloaded 22294890 bytes. 13:38:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:38:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:38:50 INFO - Return code: 0 13:38:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:50 INFO - https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:38:51 INFO - Downloaded 22294890 bytes. 13:38:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:38:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:38:52 INFO - Return code: 0 13:38: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')]} 13:38:52 INFO - https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:38:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:38:53 INFO - Downloaded 10840145 bytes. 13:38:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:38:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:38:54 INFO - Return code: 0 13:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:38:54 INFO - https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:38:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:38:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:38:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:39:10 INFO - Downloaded 54835274 bytes. 13:39:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:39:10 INFO - mkdir: /builds/slave/test/properties 13:39:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:39:10 INFO - Writing to file /builds/slave/test/properties/build_url 13:39:10 INFO - Contents: 13:39:10 INFO - build_url:https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:39:11 INFO - Running post-action listener: _resource_record_post_action 13:39:11 INFO - Running post-action listener: set_extra_try_arguments 13:39:11 INFO - ##### 13:39:11 INFO - ##### Running populate-webroot step. 13:39:11 INFO - ##### 13:39:11 INFO - Running pre-action listener: _resource_record_pre_action 13:39:11 INFO - Running main action method: populate_webroot 13:39:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:39:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:39:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:39:11 INFO - '--tppagecycles', 13:39:11 INFO - '7'], 13:39:11 INFO - 'tests': ['tsvgm']}}, 13:39:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:39:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:39:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:39:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:39:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['damp', 'tps']}, 13:39:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'tests': ['damp', 'tps']}, 13:39:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['dromaeo_dom']}, 13:39:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:39:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['a11yr', 13:39:11 INFO - 'ts_paint', 13:39:11 INFO - 'tpaint', 13:39:11 INFO - 'sessionrestore', 13:39:11 INFO - 'sessionrestore_no_auto_restore', 13:39:11 INFO - 'tabpaint']}, 13:39:11 INFO - 'other-e10s': {'tests': ['a11yr', 13:39:11 INFO - 'ts_paint', 13:39:11 INFO - 'tpaint', 13:39:11 INFO - 'sessionrestore', 13:39:11 INFO - 'sessionrestore_no_auto_restore', 13:39:11 INFO - 'tabpaint']}, 13:39:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:39:11 INFO - 'ts_paint', 13:39:11 INFO - 'tpaint', 13:39:11 INFO - 'sessionrestore', 13:39:11 INFO - 'sessionrestore_no_auto_restore', 13:39:11 INFO - 'tabpaint']}, 13:39:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:39:11 INFO - 'ts_paint', 13:39:11 INFO - 'tpaint', 13:39:11 INFO - 'sessionrestore', 13:39:11 INFO - 'sessionrestore_no_auto_restore', 13:39:11 INFO - 'tabpaint']}, 13:39:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['a11yr', 13:39:11 INFO - 'ts_paint', 13:39:11 INFO - 'tpaint', 13:39:11 INFO - 'sessionrestore', 13:39:11 INFO - 'sessionrestore_no_auto_restore', 13:39:11 INFO - 'tabpaint']}, 13:39:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['a11yr', 13:39:11 INFO - 'ts_paint', 13:39:11 INFO - 'tpaint', 13:39:11 INFO - 'sessionrestore', 13:39:11 INFO - 'sessionrestore_no_auto_restore', 13:39:11 INFO - 'tabpaint']}, 13:39:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['tsvgx', 13:39:11 INFO - 'tsvgr_opacity', 13:39:11 INFO - 'tart', 13:39:11 INFO - 'tscrollx', 13:39:11 INFO - 'cart']}, 13:39:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:39:11 INFO - 'tsvgr_opacity', 13:39:11 INFO - 'tart', 13:39:11 INFO - 'tscrollx', 13:39:11 INFO - 'cart']}, 13:39:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'talos_options': ['--disable-e10s'], 13:39:11 INFO - 'tests': ['tp5o']}, 13:39:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'tests': ['tp5o']}, 13:39:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'talos_options': ['--disable-e10s', 13:39:11 INFO - '--xperf_path', 13:39:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:11 INFO - 'tests': ['tp5n']}, 13:39:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:11 INFO - 'talos_options': ['--xperf_path', 13:39:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:11 INFO - 'tests': ['tp5n']}}, 13:39:11 INFO - 'talos.zip': {'path': '', 13:39:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:39:11 INFO - Running post-action listener: _resource_record_post_action 13:39:11 INFO - ##### 13:39:11 INFO - ##### Running create-virtualenv step. 13:39:11 INFO - ##### 13:39:11 INFO - Running pre-action listener: _resource_record_pre_action 13:39:11 INFO - Running main action method: create_virtualenv 13:39:11 INFO - Creating virtualenv /builds/slave/test/build/venv 13:39:11 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 13:39:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:39:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:39:11 INFO - Using real prefix '/usr' 13:39:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:39:12 INFO - Installing distribute.............................................................................................................................................................................................done. 13:39:14 INFO - Installing pip.................done. 13:39:14 INFO - Return code: 0 13:39:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:39:14 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')]} 13:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:14 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')]} 13:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:14 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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39:14 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 13:39:14 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 13:39:14 INFO - Using env: {'DISPLAY': ':0', 13:39:14 INFO - 'HOME': '/home/cltbld', 13:39:14 INFO - 'LANG': 'en_US.UTF-8', 13:39:14 INFO - 'LANGUAGE': 'en_US:en', 13:39:14 INFO - 'LOGNAME': 'cltbld', 13:39:14 INFO - 'MAIL': '/var/mail/cltbld', 13:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:14 INFO - 'MOZ_NO_REMOTE': '1', 13:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:14 INFO - 'NO_EM_RESTART': '1', 13:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:14 INFO - 'PWD': '/builds/slave/test', 13:39:14 INFO - 'SHELL': '/bin/bash', 13:39:14 INFO - 'SHLVL': '1', 13:39:14 INFO - 'TERM': 'linux', 13:39:14 INFO - 'TMOUT': '86400', 13:39:14 INFO - 'USER': 'cltbld', 13:39:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:14 INFO - '_': '/tools/buildbot/bin/python'} 13:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:14 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 13:39:14 INFO - Cleaning up... 13:39:14 INFO - Return code: 0 13:39:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:39:14 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')]} 13:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:14 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')]} 13:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:14 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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39:14 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 13:39:14 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 13:39:14 INFO - Using env: {'DISPLAY': ':0', 13:39:14 INFO - 'HOME': '/home/cltbld', 13:39:14 INFO - 'LANG': 'en_US.UTF-8', 13:39:14 INFO - 'LANGUAGE': 'en_US:en', 13:39:14 INFO - 'LOGNAME': 'cltbld', 13:39:14 INFO - 'MAIL': '/var/mail/cltbld', 13:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:14 INFO - 'MOZ_NO_REMOTE': '1', 13:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:14 INFO - 'NO_EM_RESTART': '1', 13:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:14 INFO - 'PWD': '/builds/slave/test', 13:39:14 INFO - 'SHELL': '/bin/bash', 13:39:14 INFO - 'SHLVL': '1', 13:39:14 INFO - 'TERM': 'linux', 13:39:14 INFO - 'TMOUT': '86400', 13:39:14 INFO - 'USER': 'cltbld', 13:39:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:14 INFO - '_': '/tools/buildbot/bin/python'} 13:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:15 INFO - Downloading/unpacking psutil>=0.7.1 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:39:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:17 INFO - Installing collected packages: psutil 13:39:17 INFO - Running setup.py install for psutil 13:39:17 INFO - building 'psutil._psutil_linux' extension 13:39: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 13:39:18 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 13:39:18 INFO - building 'psutil._psutil_posix' extension 13:39:18 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 13:39:18 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 13:39:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:18 INFO - Successfully installed psutil 13:39:18 INFO - Cleaning up... 13:39:18 INFO - Return code: 0 13:39:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39: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 13:39: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 13:39:18 INFO - Using env: {'DISPLAY': ':0', 13:39:18 INFO - 'HOME': '/home/cltbld', 13:39:18 INFO - 'LANG': 'en_US.UTF-8', 13:39:18 INFO - 'LANGUAGE': 'en_US:en', 13:39:18 INFO - 'LOGNAME': 'cltbld', 13:39:18 INFO - 'MAIL': '/var/mail/cltbld', 13:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:18 INFO - 'MOZ_NO_REMOTE': '1', 13:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:18 INFO - 'NO_EM_RESTART': '1', 13:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:18 INFO - 'PWD': '/builds/slave/test', 13:39:18 INFO - 'SHELL': '/bin/bash', 13:39:18 INFO - 'SHLVL': '1', 13:39:18 INFO - 'TERM': 'linux', 13:39:18 INFO - 'TMOUT': '86400', 13:39:18 INFO - 'USER': 'cltbld', 13:39:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:18 INFO - '_': '/tools/buildbot/bin/python'} 13:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:39: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) 13:39:20 INFO - Installing collected packages: mozsystemmonitor 13:39:20 INFO - Running setup.py install for mozsystemmonitor 13:39:20 INFO - Successfully installed mozsystemmonitor 13:39:20 INFO - Cleaning up... 13:39:20 INFO - Return code: 0 13:39:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39: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 13:39: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 13:39:20 INFO - Using env: {'DISPLAY': ':0', 13:39:20 INFO - 'HOME': '/home/cltbld', 13:39:21 INFO - 'LANG': 'en_US.UTF-8', 13:39:21 INFO - 'LANGUAGE': 'en_US:en', 13:39:21 INFO - 'LOGNAME': 'cltbld', 13:39:21 INFO - 'MAIL': '/var/mail/cltbld', 13:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:21 INFO - 'MOZ_NO_REMOTE': '1', 13:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:21 INFO - 'NO_EM_RESTART': '1', 13:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:21 INFO - 'PWD': '/builds/slave/test', 13:39:21 INFO - 'SHELL': '/bin/bash', 13:39:21 INFO - 'SHLVL': '1', 13:39:21 INFO - 'TERM': 'linux', 13:39:21 INFO - 'TMOUT': '86400', 13:39:21 INFO - 'USER': 'cltbld', 13:39:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:21 INFO - '_': '/tools/buildbot/bin/python'} 13:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:21 INFO - Downloading/unpacking blobuploader==1.2.4 13:39:21 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 13:39:21 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 13:39:21 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 13:39:21 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 13:39:21 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 13:39:21 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 13:39:23 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 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 13:39:23 INFO - Downloading docopt-0.6.1.tar.gz 13:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:23 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:23 INFO - Running setup.py install for blobuploader 13:39:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:23 INFO - Running setup.py install for requests 13:39:24 INFO - Running setup.py install for docopt 13:39:24 INFO - Successfully installed blobuploader requests docopt 13:39:24 INFO - Cleaning up... 13:39:24 INFO - Return code: 0 13:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:24 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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39:24 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 13:39:24 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 13:39:24 INFO - Using env: {'DISPLAY': ':0', 13:39:24 INFO - 'HOME': '/home/cltbld', 13:39:24 INFO - 'LANG': 'en_US.UTF-8', 13:39:24 INFO - 'LANGUAGE': 'en_US:en', 13:39:24 INFO - 'LOGNAME': 'cltbld', 13:39:24 INFO - 'MAIL': '/var/mail/cltbld', 13:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:24 INFO - 'MOZ_NO_REMOTE': '1', 13:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:24 INFO - 'NO_EM_RESTART': '1', 13:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:24 INFO - 'PWD': '/builds/slave/test', 13:39:24 INFO - 'SHELL': '/bin/bash', 13:39:24 INFO - 'SHLVL': '1', 13:39:24 INFO - 'TERM': 'linux', 13:39:24 INFO - 'TMOUT': '86400', 13:39:24 INFO - 'USER': 'cltbld', 13:39:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:24 INFO - '_': '/tools/buildbot/bin/python'} 13:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:24 INFO - Running setup.py (path:/tmp/pip-jOB4GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:24 INFO - Running setup.py (path:/tmp/pip-ofVDTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:24 INFO - Running setup.py (path:/tmp/pip-9TFL89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:24 INFO - Running setup.py (path:/tmp/pip-zm1N7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:24 INFO - Running setup.py (path:/tmp/pip-TjaxCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:25 INFO - Running setup.py (path:/tmp/pip-lzp4uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:25 INFO - Running setup.py (path:/tmp/pip-K2Ixjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:25 INFO - Running setup.py (path:/tmp/pip-l6tMf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:25 INFO - Running setup.py (path:/tmp/pip-iAEP3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:25 INFO - Running setup.py (path:/tmp/pip-RRSAiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:25 INFO - Running setup.py (path:/tmp/pip-E7SAWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:25 INFO - Running setup.py (path:/tmp/pip-XQSIQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:25 INFO - Running setup.py (path:/tmp/pip-VGmIl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:25 INFO - Running setup.py (path:/tmp/pip-7sHM_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:25 INFO - Running setup.py (path:/tmp/pip-RFhAtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:25 INFO - Running setup.py (path:/tmp/pip-EQidPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:25 INFO - Running setup.py (path:/tmp/pip-6T2NL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:25 INFO - Running setup.py install for manifestparser 13:39:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:25 INFO - Running setup.py install for mozcrash 13:39:26 INFO - Running setup.py install for mozdebug 13:39:26 INFO - Running setup.py install for mozdevice 13:39:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Running setup.py install for mozfile 13:39:26 INFO - Running setup.py install for mozhttpd 13:39:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Running setup.py install for mozinfo 13:39:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Running setup.py install for mozInstall 13:39:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Running setup.py install for mozleak 13:39:26 INFO - Running setup.py install for mozlog 13:39:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:26 INFO - Running setup.py install for moznetwork 13:39:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:27 INFO - Running setup.py install for mozprocess 13:39:27 INFO - Running setup.py install for mozprofile 13:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:27 INFO - Running setup.py install for mozrunner 13:39:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:27 INFO - Running setup.py install for mozscreenshot 13:39:27 INFO - Running setup.py install for moztest 13:39:27 INFO - Running setup.py install for mozversion 13:39:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:27 INFO - Cleaning up... 13:39:27 INFO - Return code: 0 13:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39: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 13:39: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 13:39:27 INFO - Using env: {'DISPLAY': ':0', 13:39:27 INFO - 'HOME': '/home/cltbld', 13:39:27 INFO - 'LANG': 'en_US.UTF-8', 13:39:27 INFO - 'LANGUAGE': 'en_US:en', 13:39:27 INFO - 'LOGNAME': 'cltbld', 13:39:27 INFO - 'MAIL': '/var/mail/cltbld', 13:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:27 INFO - 'MOZ_NO_REMOTE': '1', 13:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:27 INFO - 'NO_EM_RESTART': '1', 13:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:27 INFO - 'PWD': '/builds/slave/test', 13:39:27 INFO - 'SHELL': '/bin/bash', 13:39:27 INFO - 'SHLVL': '1', 13:39:27 INFO - 'TERM': 'linux', 13:39:27 INFO - 'TMOUT': '86400', 13:39:27 INFO - 'USER': 'cltbld', 13:39:27 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:27 INFO - '_': '/tools/buildbot/bin/python'} 13:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:27 INFO - Running setup.py (path:/tmp/pip-q9CCQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39: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)) 13:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:27 INFO - Running setup.py (path:/tmp/pip-XTt8_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:28 INFO - Running setup.py (path:/tmp/pip-H11QRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:28 INFO - Running setup.py (path:/tmp/pip-bnYWte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:28 INFO - Running setup.py (path:/tmp/pip-iH4RWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:28 INFO - Running setup.py (path:/tmp/pip-egP03y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:28 INFO - Running setup.py (path:/tmp/pip-KVPLey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:28 INFO - Running setup.py (path:/tmp/pip-ukmvOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:28 INFO - Running setup.py (path:/tmp/pip-S3UP8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:28 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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:28 INFO - Running setup.py (path:/tmp/pip-vhBNEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39: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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:28 INFO - Running setup.py (path:/tmp/pip-6k_Osb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39: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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:28 INFO - Running setup.py (path:/tmp/pip-UD_tvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39: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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:28 INFO - Running setup.py (path:/tmp/pip-KjizKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39: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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:28 INFO - Running setup.py (path:/tmp/pip-CKK1mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39: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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:28 INFO - Running setup.py (path:/tmp/pip-94Ohrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39: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)) 13:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:28 INFO - Running setup.py (path:/tmp/pip-wIlays-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:29 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)) 13:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:29 INFO - Running setup.py (path:/tmp/pip-sm3Hid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:29 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)) 13:39:29 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)) 13:39:29 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)) 13:39:29 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)) 13:39:29 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)) 13:39:29 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)) 13:39:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:29 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 13:39:30 INFO - Downloading blessings-1.6.tar.gz 13:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:31 INFO - Installing collected packages: blessings 13:39:31 INFO - Running setup.py install for blessings 13:39:31 INFO - Successfully installed blessings 13:39:31 INFO - Cleaning up... 13:39:31 INFO - Return code: 0 13:39:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:31 INFO - Reading from file tmpfile_stdout 13:39:31 INFO - Current package versions: 13:39:31 INFO - argparse == 1.2.1 13:39:31 INFO - blessings == 1.6 13:39:31 INFO - blobuploader == 1.2.4 13:39:31 INFO - docopt == 0.6.1 13:39:31 INFO - manifestparser == 1.1 13:39:31 INFO - mozInstall == 1.12 13:39:31 INFO - mozcrash == 0.17 13:39:31 INFO - mozdebug == 0.1 13:39:31 INFO - mozdevice == 0.48 13:39:31 INFO - mozfile == 1.2 13:39:31 INFO - mozhttpd == 0.7 13:39:31 INFO - mozinfo == 0.9 13:39:31 INFO - mozleak == 0.1 13:39:31 INFO - mozlog == 3.1 13:39:31 INFO - moznetwork == 0.27 13:39:31 INFO - mozprocess == 0.22 13:39:31 INFO - mozprofile == 0.28 13:39:31 INFO - mozrunner == 6.11 13:39:31 INFO - mozscreenshot == 0.1 13:39:31 INFO - mozsystemmonitor == 0.0 13:39:31 INFO - moztest == 0.7 13:39:31 INFO - mozversion == 1.4 13:39:31 INFO - psutil == 3.1.1 13:39:31 INFO - requests == 1.2.3 13:39:31 INFO - wsgiref == 0.1.2 13:39:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:31 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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39:31 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 13:39:31 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 13:39:31 INFO - Using env: {'DISPLAY': ':0', 13:39:31 INFO - 'HOME': '/home/cltbld', 13:39:31 INFO - 'LANG': 'en_US.UTF-8', 13:39:31 INFO - 'LANGUAGE': 'en_US:en', 13:39:31 INFO - 'LOGNAME': 'cltbld', 13:39:31 INFO - 'MAIL': '/var/mail/cltbld', 13:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:31 INFO - 'MOZ_NO_REMOTE': '1', 13:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:31 INFO - 'NO_EM_RESTART': '1', 13:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:31 INFO - 'PWD': '/builds/slave/test', 13:39:31 INFO - 'SHELL': '/bin/bash', 13:39:31 INFO - 'SHLVL': '1', 13:39:31 INFO - 'TERM': 'linux', 13:39:31 INFO - 'TMOUT': '86400', 13:39:31 INFO - 'USER': 'cltbld', 13:39:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:31 INFO - '_': '/tools/buildbot/bin/python'} 13:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39: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)) 13:39:31 INFO - Cleaning up... 13:39:31 INFO - Return code: 0 13:39:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39: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 13:39: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 13:39:31 INFO - Using env: {'DISPLAY': ':0', 13:39:31 INFO - 'HOME': '/home/cltbld', 13:39:31 INFO - 'LANG': 'en_US.UTF-8', 13:39:31 INFO - 'LANGUAGE': 'en_US:en', 13:39:31 INFO - 'LOGNAME': 'cltbld', 13:39:31 INFO - 'MAIL': '/var/mail/cltbld', 13:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:31 INFO - 'MOZ_NO_REMOTE': '1', 13:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:31 INFO - 'NO_EM_RESTART': '1', 13:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:31 INFO - 'PWD': '/builds/slave/test', 13:39:31 INFO - 'SHELL': '/bin/bash', 13:39:31 INFO - 'SHLVL': '1', 13:39:31 INFO - 'TERM': 'linux', 13:39:31 INFO - 'TMOUT': '86400', 13:39:31 INFO - 'USER': 'cltbld', 13:39:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:31 INFO - '_': '/tools/buildbot/bin/python'} 13:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:31 INFO - Downloading/unpacking jsonschema 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:33 INFO - Downloading/unpacking functools32 (from jsonschema) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:34 INFO - warning: no files found matching '*.txt' 13:39:34 INFO - no previously-included directories found matching 'build' 13:39:34 INFO - no previously-included directories found matching 'dist' 13:39:34 INFO - no previously-included directories found matching '.git*' 13:39:34 INFO - Installing collected packages: jsonschema, functools32 13:39:34 INFO - Running setup.py install for functools32 13:39:34 INFO - warning: no files found matching '*.txt' 13:39:34 INFO - no previously-included directories found matching 'build' 13:39:34 INFO - no previously-included directories found matching 'dist' 13:39:34 INFO - no previously-included directories found matching '.git*' 13:39:34 INFO - Successfully installed jsonschema functools32 13:39:34 INFO - Cleaning up... 13:39:34 INFO - Return code: 0 13:39:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f65c47f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', '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 13:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:39:34 INFO - Using env: {'DISPLAY': ':0', 13:39:34 INFO - 'HOME': '/home/cltbld', 13:39:34 INFO - 'LANG': 'en_US.UTF-8', 13:39:34 INFO - 'LANGUAGE': 'en_US:en', 13:39:34 INFO - 'LOGNAME': 'cltbld', 13:39:34 INFO - 'MAIL': '/var/mail/cltbld', 13:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:34 INFO - 'MOZ_NO_REMOTE': '1', 13:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:34 INFO - 'NO_EM_RESTART': '1', 13:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:34 INFO - 'PWD': '/builds/slave/test', 13:39:34 INFO - 'SHELL': '/bin/bash', 13:39:34 INFO - 'SHLVL': '1', 13:39:34 INFO - 'TERM': 'linux', 13:39:34 INFO - 'TMOUT': '86400', 13:39:34 INFO - 'USER': 'cltbld', 13:39:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:34 INFO - '_': '/tools/buildbot/bin/python'} 13:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:34 INFO - Downloading/unpacking flake8 13:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:39:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:39:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:39:37 INFO - no previously-included directories found matching 'docs/_build' 13:39:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:39:37 INFO - Running setup.py install for pep8 13:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:39:37 INFO - no previously-included directories found matching 'docs/_build' 13:39:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:39:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:39:37 INFO - Cleaning up... 13:39:37 INFO - Return code: 0 13:39:37 INFO - Running post-action listener: _resource_record_post_action 13:39:37 INFO - Running post-action listener: _start_resource_monitoring 13:39:37 INFO - Starting resource monitoring. 13:39:37 INFO - ##### 13:39:37 INFO - ##### Running install step. 13:39:37 INFO - ##### 13:39:37 INFO - Running pre-action listener: _resource_record_pre_action 13:39:37 INFO - Running main action method: install 13:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:37 INFO - Reading from file tmpfile_stdout 13:39:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:37 INFO - Reading from file tmpfile_stdout 13:39:37 INFO - Output received: 13:39:37 INFO - Usage: mozinstall [options] installer 13:39:37 INFO - Options: 13:39:37 INFO - -h, --help show this help message and exit 13:39:37 INFO - -d DEST, --destination=DEST 13:39:37 INFO - Directory to install application into. [default: 13:39:37 INFO - "/builds/slave/test"] 13:39:37 INFO - --app=APP Application being installed. [default: firefox] 13:39:37 INFO - mkdir: /builds/slave/test/build/application 13:39:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:39:53 INFO - Reading from file tmpfile_stdout 13:39:53 INFO - Output received: 13:39:53 INFO - /builds/slave/test/build/application/firefox/firefox 13:39:53 INFO - Running post-action listener: _resource_record_post_action 13:39:53 INFO - ##### 13:39:53 INFO - ##### Running run-tests step. 13:39:53 INFO - ##### 13:39:53 INFO - Running pre-action listener: _resource_record_pre_action 13:39:53 INFO - Running main action method: run_tests 13:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:39:53 INFO - Python 2.7.3 13:39:53 INFO - Return code: 0 13:39:53 INFO - grabbing minidump binary from tooltool 13:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:39:53 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 0x24f1410>, '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 0x24f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:39:53 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 13:39:53 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 13:39:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:39:53 INFO - Return code: 0 13:39:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:39:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:39:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:39:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:39:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:39:54 INFO - Return code: 0 13:39:54 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/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:39:54 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/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 13:39:54 INFO - Using env: {'DISPLAY': ':0', 13:39:54 INFO - 'HOME': '/home/cltbld', 13:39:54 INFO - 'LANG': 'en_US.UTF-8', 13:39:54 INFO - 'LANGUAGE': 'en_US:en', 13:39:54 INFO - 'LOGNAME': 'cltbld', 13:39:54 INFO - 'MAIL': '/var/mail/cltbld', 13:39:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:39:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:54 INFO - 'MOZ_NO_REMOTE': '1', 13:39:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:54 INFO - 'NO_EM_RESTART': '1', 13:39:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:54 INFO - 'PWD': '/builds/slave/test', 13:39:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:39:54 INFO - 'SHELL': '/bin/bash', 13:39:54 INFO - 'SHLVL': '1', 13:39:54 INFO - 'TERM': 'linux', 13:39:54 INFO - 'TMOUT': '86400', 13:39:54 INFO - 'USER': 'cltbld', 13:39:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911', 13:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:54 INFO - '_': '/tools/buildbot/bin/python'} 13:39:54 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/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:39:54 INFO - mozversion application_buildid: 20160427132147 13:39:54 INFO - mozversion application_changeset: f1ff46a78fa5f30b208b33269b48ba4ba367b34f 13:39:54 INFO - mozversion application_display_name: Nightly 13:39:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:39:54 INFO - mozversion application_name: Firefox 13:39:54 INFO - mozversion application_remotingname: firefox 13:39:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:39:54 INFO - mozversion application_vendor: Mozilla 13:39:54 INFO - mozversion application_version: 49.0a1 13:39:54 INFO - mozversion platform_buildid: 20160427132147 13:39:54 INFO - mozversion platform_changeset: f1ff46a78fa5f30b208b33269b48ba4ba367b34f 13:39:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:39:54 INFO - mozversion platform_version: 49.0a1 13:39:54 INFO - using testdate: 1461789594 13:39:54 INFO - actual date: 1461789594 13:39:54 INFO - starting webserver on 'localhost:41860' 13:39:54 INFO - SUITE-START | Running 2 tests 13:39:54 INFO - TEST-START | dromaeo_css 13:39:54 INFO - operating with platform_type : linux_ 13:39:54 INFO - Initialising browser for dromaeo_css test... 13:39:54 INFO - TEST-INFO | started process 3257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7UaBG/profile http://localhost:41860/getInfo.html) 13:39:59 INFO - PROCESS | 3257 | 13:39:59 INFO - PROCESS | 3257 | (process:3327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:40:00 INFO - PROCESS | 3257 | __metrics Screen width/height:1600/1200 13:40:00 INFO - PROCESS | 3257 | colorDepth:24 13:40:00 INFO - PROCESS | 3257 | Browser inner width/height: 1024/697 13:40:00 INFO - PROCESS | 3257 | __metrics 13:40:00 ERROR - PROCESS | 3257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:40:01 INFO - TEST-INFO | 3257: exit 0 13:40:01 INFO - Browser initialized. 13:40:01 INFO - Running cycle 1/1 for dromaeo_css test... 13:40:01 INFO - TEST-INFO | started process 3379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7UaBG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:03 INFO - PROCESS | 3379 | 13:40:03 INFO - PROCESS | 3379 | (process:3439): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:40:13 INFO - PROCESS | 3379 | RSS: Main: 165896192 13:40:13 INFO - PROCESS | 3379 | 13:41:03 INFO - PROCESS | 3379 | 1461789663146 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] 13:43:14 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41860/tests/dromaeo/cssquery-ext.html) 13:43:15 INFO - PROCESS | 3379 | RSS: Main: 171716608 13:43:15 INFO - PROCESS | 3379 | 13:46:17 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-ext.html (next: http://localhost:41860/tests/dromaeo/cssquery-jquery.html) 13:46:18 INFO - PROCESS | 3379 | RSS: Main: 167350272 13:46:18 INFO - PROCESS | 3379 | 13:49:20 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41860/tests/dromaeo/cssquery-mootools.html) 13:49:20 INFO - PROCESS | 3379 | RSS: Main: 168706048 13:49:20 INFO - PROCESS | 3379 | 13:52:22 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41860/tests/dromaeo/cssquery-prototype.html) 13:52:23 INFO - PROCESS | 3379 | RSS: Main: 166105088 13:52:23 INFO - PROCESS | 3379 | 13:55:26 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41860/tests/dromaeo/cssquery-yui.html) 13:55:26 INFO - PROCESS | 3379 | RSS: Main: 167796736 13:55:26 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | Cycle 1(1): loaded http://localhost:41860/tests/dromaeo/cssquery-yui.html (next: http://localhost:41860/tests/dromaeo/cssquery-dojo.html) 13:58:29 INFO - PROCESS | 3379 | RSS: Main: 169668608 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | __start_tp_report 13:58:29 INFO - PROCESS | 3379 | _x_x_mozilla_page_load 13:58:29 INFO - PROCESS | 3379 | _x_x_mozilla_page_load_details 13:58:29 INFO - PROCESS | 3379 | |i|pagename|runs| 13:58:29 INFO - PROCESS | 3379 | |0;dojo.html;2649;2711.051132103764;2717.2935036890403;2748.1755473358;2765.95851062234;4823.662343635947;4839.05638400512;4841.346418233542;4855.053264613402;4902.362692849929;4717.504662010491;4780;4834.444038935523;4844.878878028051;4886.780094895729;4449.466064072316;4468.5754853289045;4524.34397012433;4527.253003254459;4581.954180458186;534.5279845446645;4413.3821265022925;4425.114977004596;4508.39136716544;4547.113312903985;4475.932861007088;4494.07871386365;4499.932501012488;4512.819487220508;4525.818967241306;4350.782460876943;4560.726356418625;4561.40701708779;4597.70114942531;4618.5843274105155;4371.956280437218;4405;4424.469063712343;4442.355858400546;4445.977770111129;4596.471405788344;4608.976955115203;4655.441347038343;4658.930116048262;4721.315409265637;5028.522290382408;5092.8472145835685;5103.744812759384;5107.157319042353;5109.029284435946;5154.664946778447;5176.6893986360565;5181.922271165936;5186.948130518685;5230.424653288135;4791.472937976785;4801.927971080437;4808.8797780055775;4821.614270858393;4842.080004799112;5122.206058061007;5238.92141617876;5260.28986086881;5261.13191323435;5345.278387417727;5055.09008378488;5094.923576146361;5095.949040509621;5097.515736005073;5124.718140502234;5171.276021357013;5180.844574662766;5205.427402985669;5213.973930130325;5218.530332270114;4928.605711543068;5016.2224855147515;5105.9489405106215;5106.719130447861;5118.564921981673;4981.302617633534;4990.850274491771;5026.29631851541;5036.84889453317;5098.5411312982005;4241.681873859473;4265.424167737316;4266.935995960063;4298.990706505459;4306.870793876126;3684.0421490412687;3748.11919198988;3783.39465685489;3801.4107813288983;3817.255635151119;4506.504284528699;4513.909721805546;4525;4563.429571303587;4572.817087316536;5157.381114266312;5177.326947496801;5206.140986737221;5208.374995000624;5211.791528338824;4326.17802617508;4393.20922234001;4474.843380481732;4527.275635898241;4563.680542362003;4628.907421851544;4651.511591282867;4652.604528615106;4676.3686902267755;4695.577398034194;4972.950270497321;4979.875503112451;4991.650584459053;5000.274960130833;5001.499850015042;5051.368578927634;5221.608379371486;5224.660397074178;5298.97350513245;5314;4950.554450099508;4971.229459433794;4978.303037574815;4983.825566105169;5028.497150284942;5112.130937740668;5114.15616423286;5114.693118412758;5117.181250999822;5121.1550094234035;4973.900521989613;5093.847184584469;5204.557612602971;5229.450907654794;5256.921146182887;4949.505049495022;4950.900981980412;4993.251012348177;4996.225585034325;5043.2939388486375;4935.802567897387;4979.477154898828;4981.277714731271;4994.175960966545;4996;4792.664513484023;4844.854654360375;4914.459409464885;4919.729414882073;4943.184374578154;4991.925121123259;5006.07387633289;5014.598832093497;5020.924686129638;5062.544371006627;4917.360743103373;4920.40955085392;4923.704577725348;4936.185529387611;4963.03220871941 13:58:29 INFO - PROCESS | 3379 | |1;ext.html;575.7898367096011;594.7531774313659;617.4288782875839;617.6880675258993;635.4852569418774;33168.834155829216;34154.14614634632;34304.82847585765;34321;34401.65598344022;34597.82701086491;35659.643403565955;35843.103922401955;35874.282514349696;35900.2819943601;7501.099868015832;7664.156942736295;7690.230976902321;7718.807029824243;7730;7530.134034586038;7638.427117966147;7674.424418168632;7889.8816517752275;7900;7858.29275365217;7902.960485197595;7925;7926.207379262085;7958.4031197660115;7801.297883190512;7820.960895195488;7855;7860.213978602123;7866.724664636738;7779.37764978806;7814.3357814585825;7834.451588388815;7871.330936870373;7877.724279650242;35768.64231357679;35835.462468063;36208.63791362079;36237.45643815345;36350.27299453996;2352.800011998982;2944.1167649705003;2996.340805022913;3046.482098043316;3469.9479507807405;25241.747582524124;25531.872340638365;25801.741982580308;25853.74146258532;25972.35069123268;3286.3263031078573;3312.1222875937897;3338.4491558892755;3409.931801363959;3427.417339052367;153688;153792;154189;154544.227278864;154933;48190.75904620454;48848.75575622099;48853;48963.26555101676;49136.26295605569;47764;48913.51086489089;49156.75421622869;49166.75416622966;52193.7390313046;13937.721245575032;14076.225807580477;14132.788008179885;14146.29268536569;14168.362423690958;11473.311601303782;11498.94250528742;11545.48045337945;11570.710732231593;11616.593419230287;16860.74708879368;17350.91324543369;17393.130343482775;17432.82567174312;17563;6701.564398314094;6971.268016858258;7012.123484564429;7044.788656340318;7163.820904477326;862.4782006885869;952.5614427066731;955.5174636808506;986.6004268271362;1064.7018834726289;25065.62401563978;25570.744292556836;25793.484130317665;25828.48343033129;25928.740712592633;988.5452691761726;1005.6731562242154;1050.9962985348973;1072.6084978982772;1073.3345325897837;13492.12301200419;13633.659158521117;13710;13887.236202008784;14221.502247421291;258408;260941;261343;263279;264049;45099.774501127285;45465.77267113709;45817.541824582;45843.31235031477;45959.31061034087;1202.6091520255952;1233.0751936047784;1235.7096082420624;1245.40843099527;1269.149669721289;24167.532779021793;25472.032599088026;26390.340241493348;26460.338491537095;26543.203703888914;39535.406968896066;39952.40071398873;40269.59730402658;40298.79850600728;40315.596844031184;240103;241215;241315;241687;241804;23737.762622373557;23854.761452385254;24233;24649.87675061613;24663.136790212975;39415.408768867914;39441.60558394379;39603.60396395999;39608;40242;33443.163920902174;33460.83269583636;33751.83124084462;34660.82669586636;35105.29789404249;33035.669643303256;33793.49309760307;33796.15509612181;33908.15229619279;34347.31305373828;26622.866885665448;31212.375752484368;31830.180378354744;33395.499067514495;33948.66051339455;28099;28124.156275311772;28202;28351.29121771972;28516.716747746817;23478;23689.763102368757;23798.286051418487;24114.276571702878;24124.396890077187 13:58:29 INFO - PROCESS | 3379 | |2;jquery.html;371.0038546502642;372.14963807699405;374.2720408804874;375.8853549667351;387.30865405251615;15240.390384384626;15774.132422716746;16693.582660433494;16719.164041797907;16921.915390423062;15678.216089195552;15932.283047262872;16458.423955161572;16515.174241287947;16568.17159142041;4967.950320496794;5099.36257967754;5100.489951004907;5144.4598317176715;5146.588272938156;3666.779993200403;5058.317127187819;5568;5862.853428664275;5879.1475236090955;5784.826455206329;5817.621854579439;5824.767009319622;5837.357890632027;5840.211571437865;5652.463016013472;5891.941080589225;5920.4671579557835;5920.97039514804;5922.082077278029;4835.419749630032;5192.71440070796;5203.14148165556;5204.42751297357;5213.843584692465;12046.15676902617;12161.695957601043;12186.75626487474;12223.69440763979;12283.631491055283;1762.365548402574;1852.351676913083;1876.9343072992517;1879.4455635587399;1930.94207173785;8646.308295336357;9050.683226087122;9357.625694972194;9409.717708468688;9480.146786789222;1729.7578339032546;1748.6852366574012;1791.811859754733;1830.752848365467;1855.3691744806831;48378.27432588479;60427.69786151085;61597.38402615961;61723.691381543256;62146.37853621451;9055.23030542398;9581.760455988657;9610.183134433511;10141.391516508886;10226.795464090677;13677.794833077513;13688.315584220949;13779.793303100461;13780.10429322091;13835.861641383457;7200.891986620205;7426.480146389809;7471.925280747123;7535;7561.697532098655;6995.93004069963;7099.36105750485;7176.067111275501;7193.604351760599;7250.492465527363;4264.296391095497;4380.452443444569;4394.978025109854;4459.375687403766;4464.549021568004;1682.2513981278457;1774.157275294225;1820.8816426932208;1845.9446216613524;1879.5489082620072;852.3181454836106;885.274075258282;921.6221349246911;932.9533523323943;936.7939053408239;14502.564923052325;15355.846441535665;15616.3753449863;15890.9670871393;16382;887.5961437545901;907.6414816147585;911.2800887299092;933.1228645073609;933.6545478172984;9005.729828105168;9120.58957346921;9248.121428464285;9406.71779846592;9430.764230894283;249378;249525;251903;356655;375106;44849.32726009112;46719.87754209501;71250.64374678093;72441.27558724451;76038.6198069006;918.4443411735804;918.8759517465056;963.6964356227766;964;975.7658162041059;14296.714065718419;14302.785458217926;14508.274586270856;14604.634884127558;14928.178950157846;32435;32645.510317344782;32646.020619381456;34291.4856277161;36438.453423198145;43600.34599481074;44820.77589612162;45577;46220.537794621625;46528.767356163;10831.350118992885;10975.945120274668;10991.835122473009;11066.28069175501;11093.667189984313;8466.74599762008;9506.57401389797;11720.589779357682;12109.939450302692;12177.086718495972;9913.504324783877;9965.950170249393;9990.450525221182;10168.28821982454;10287.53706083213;10037.197024237897;10156.79686406253;10328.586856525655;10430.16558675289;10631.734206644896;10210.948945255226;10219.795604087727;10355.844662330222;10611.787764244826;10680.412577308323;10905.563777448813;10930.125589952944;10999.560017599206;11001.504932277907;11148.219624626197;10789.136869050613;10911.236213464981;10927.781444371227;10966.122710183006;10969.286996345212 13:58:29 INFO - PROCESS | 3379 | |3;mootools.html;1418.3900922603284;1488.0030379645636;1552.6244845386564;1702.6084000679837;1758.7625670534483;6477.708503117359;7013.89479157813;7059.3293637104525;7351.595662238575;7363.337299643031;7205.531640443381;7293;7362.527494501094;7377.2253913339;7378.372838308736;2210.403191138392;2233.597952368573;2242.7757224277525;2247.067467001201;2248.190651365507;2122.0238690202527;2128.9574208515896;2184.530325979914;2184.868907865533;2187.835912306575;2232.2410380470637;2239.9216027439043;2245;2251.763564825694;2263.60386932287;2157.5253444242244;2158.665406861931;2163.2536774812665;2182.6289530779727;2185.606590813653;2163.1888041984257;2186.6719992001326;2187.103287652055;2212.54642798226;2223.2774348336857;7346.669399877019;7361.889571656429;7443.255674432514;7450.18048014718;7453.776386708408;4520.186366454037;4584.289435137559;4613.054323863634;4627.514111018329;4653.906921861578;2895.0139240132557;3058.4189004089153;3074.8616312266004;3083.691630836921;3109.9067027989195;953.4517652349857;955.44106697582;981.3572110267786;1004.7689031522791;1013.1692012549712;9569.234461243084;9741.853872191923;9794.16749576287;9821.066998635119;9861.950690246504;4231.830726770895;4328.199283132631;4363.978180109143;4370.169667763115;4370.67219958498;8524.445911015764;8578.613962371708;8595.613197406132;8627.439216451035;8627.741167764978;4656.464506581787;4704.788284527204;4713.434387873409;4728.71627702339;4736.289556566474;3679.19057807282;4160.521540022875;4174.186033723395;4226;4280.058387154821;3616.349057169682;3646.9635303647156;3699.241655460678;3749.5500539934837;3756.7745935243975;1260.703734622363;1278.961631151067;1285.3123578885438;1294.0294778915813;1294.2622705058027;790.2453157234827;895.5969813583913;897.0849733272156;913.3332667153015;933.659214386744;5223.817166399158;5347.812826551052;5350.5184533392185;5479.945200548023;5550.639208451437;423.93429018502184;434.97825108744433;435.76686472736935;447.40495141461776;448.0143683895443;3641.1625326175126;3678.1172518595345;3703.203811180555;3762.5108735864164;3765.9058523536582;8767.342449316327;9162.083791620784;9175.724728258163;9258.768530786649;9283.303752218475;9099.81800363989;9236.630534778533;9240.21458176049;9250.167484926389;9284.25725941923;7052.294770522906;7056.15326160864;7114.608696521637;7187.281271872771;7220.169680486706;5170.784865556667;5295.232191332312;5296.602754793329;5395.24466574672;5446.509814116748;8579.699710510102;8596.699115530926;8607.913920860712;8625.525596092024;8660.220580147818;8471.32229421657;8654;8726.214640682369;8827.337949653931;8878.95560522219;5609.88780224385;6267.9373206267355;6291.842703932438;6515.54391192612;6615.66921653925;6892.276310987274;6962.373386395248;7024.613646249505;7039.084918960707;7057.929420705727;6410.967945160244;6578.967105164444;6583.407493325623;6617.503687223381;6671.46628269747;6336.334684858023;6480.513961453004;6494.155759751202;6521.739130434919;6565.376289252514;6342.39747224013;6358.650274234961;6384.265809431789;6413.8717225656155;6418.326075761977;4436.401085853368;4532.932006019978;4592.196365635934;4631.166390049689;4660.673752837269;4637.165310244189;4654.4414670239785;4658.697184682985;4659.60393366554;4728.0780247851335 13:58:29 INFO - PROCESS | 3379 | |4;prototype.html;286.3971340328607;301.68624630384403;302.6398585683037;305.8944664090888;308.81779749947555;4771.90456190876;4830.855074347766;4880.023590445866;4957.925631115536;5002.599792016639;4916.139675556781;4962.975185124069;4972.2541618757205;4986.950130498694;5007.549320561149;3888.494495715553;3915.3539665955227;3930.764154150753;3934.7245692801516;3947.940780888289;3666.5600127984544;3920.882373528799;3936.2717897189114;3948.348522493785;3952.9524675960893;3817.4846395736636;3823.4456003879422;3854.3062248795204;3857.1321452673205;3859.9035024124482;3822.7706337619834;3842.058695619563;3842.8270727817317;3842.9423558646504;3856.5564960029674;3374.9156271093175;3375.7468189885612;3376.915577110592;3380.780249283813;3386.3227354529195;4616.1229366420275;4739.810407583693;4771.141194584973;4771.880702982418;4779.211430114027;4312.568743125694;4318.395424640553;4345.891352716176;4350.216960947028;4358.760268185249;5133.743312834381;5145.742712864342;5161.896762064775;5167.354080739908;5168.250603662485;3564.2592456256393;3597.94603080954;3634.273145370936;3667.853285868562;3670.504481894937;5356.035913535562;5365.248865158881;5434;5437.157240627709;5449.945500545023;3718.6281371862597;3723.3298006359114;3728.3289007978824;3745.6628903398823;3754.597057882957;3770.132869440044;3794.9430758538642;3803.432682939005;3806.8096595170687;3825.3688141456905;4074.246264441088;4325.416068830667;4336.978315108404;4350.73895566267;4357.564243575617;5185.948140518622;5198.960207958424;5213.191955246943;5226.869328266747;5230.450802665741;1295.2552282437637;1333.2467156056796;1373.587923622909;1375.2229990055587;1378.1248906944163;899.6401439424283;912.9634814607474;918.673870775865;919.0671468459519;934.5841100710119;4809.44691360498;4837.306942570142;4869.245266983623;4870.975645121752;4878.902421951541;5592.384837667853;5644.125160600113;5689.601727879009;5692.48767610917;5695.7152142392715;4743.620510359163;4809.2305231162845;4819.554133759858;4826.879328016757;4847.321375007502;2985.000024991609;3012.2770535071863;3037.9544306835414;3042.2546476113494;3045.6040714706946;5363.249145119687;5395.892082158335;5410.890767392675;5416.83749487516;5427.240186373911;5595.608307418523;5681.119426488901;5764.798232061858;5776.306843178845;5786.479216870418;5358.383785864676;5370.409254981949;5379.273798037293;5389.7035663038905;5402.648827826179;5521.5306698931045;5602.831915042555;5639.802606908903;5651.265335506358;5660.51885589713;5474.2609747683555;5483.890322193613;5526.917096243479;5539.806106786243;5541.5289700375915;5349.625526213128;5375.059364611256;5384.21928820311;5405.162199859028;5440.183972404171;3533.876314328986;3905.8477749063527;3907.765534067965;3911.882643520699;3912.5891781362548;5066.264217322604;5321.441248668834;5338.1992701093595;5369.865753356197;5373.596980226421;5018.2436147348135;5195.428502864606;5232.215167724719;5246.842594722164;5249.947500524946;5111.539961403491;5226.398964119175;5228.320318358589;5233.476652334888;5260.474972013531;4867.610591152628;5130.333056702754;5138.792383789882;5166.741662916915;5177.948220517746;5286.9735651323035;5288.286081378965;5290.25936368901;5300.920486192633;5304.60215483848;5152.433232344364;5153.510416510426;5153.922691159561;5177.7670004849115;5193.195054766517 13:58:29 INFO - PROCESS | 3379 | |5;yui.html;683.1528904158841;686.5640318397819;716.5020310883934;742.6435311050695;746.9439792015601;11563.479643416045;11591.072714182867;11804.586839460631;12994;13498.59504214875;13050.869491305084;13092.34538273085;13144.671383215424;13184.538541151062;13280.800787988188;636.8248731598801;811.6063709101096;820.2371794231362;820.7989042684521;820.8891799607036;792.3106896999618;817.448222449844;821.2321479416735;823.9629216685264;826.3348004856089;855.1832999485476;862.5945805471418;865.3726048614735;868.5657171414293;869.2437579306013;856.4047986649313;859.3769517100114;864.0754392799707;866.4324867211986;866.4801119328415;629.3580547841223;631.2614241337646;632.6710110742388;634.3497914637487;634.784173381048;13037.86962130376;13098.672533186651;13110.934445327808;13118.86881131186;13124.343782810822;12688.746225075447;12806.551770688075;12814.487420503168;12818.230906145662;13113;9848.113669769684;9888.505574721235;9909.157721593674;9979;10173.440460774655;3092.1805721483825;3111.4243864884843;3120.719135277836;3173.7461003119697;3199.808011519316;47603.57189284327;47604.7619761899;47935.28097078547;48394.5160548397;48593;9964.402135871871;9972.551235194434;9980.950095249478;10074.69775906724;10191.337563058378;15970.68058638844;18021.7296740549;18100.818991810178;18125.728114078298;18149.092545372678;6758.560693554903;6828.146481689789;6884.311568843075;6968.477364197604;6982.092327997328;3749.1939233064477;3813.790241536742;3848.6536211741077;3915.92168156641;3926.784026878492;2894.6526416830116;2954.852257387165;2988.656304524964;3094.6905309469325;3095.4892442747146;570.9029464990962;577.783331250781;580.0718849840306;583.12822330616;586.6304228336121;550.529297450682;580.7328628830701;663.8207683925409;665.7869481765886;672.2437258084655;8114.63484143215;8298.377621678399;8302.086770455246;8333.708320208763;8551.315894728532;445.40315976591523;532.9413764485903;568.9658620482784;624.7376102037156;666.6833254204311;3549.751517393809;3754.305453491113;3807.1814559869763;3827.7129215308964;3915.353966595537;51722.224166637534;51767.22349164765;52804.20793688098;53024;53178.46821531735;45291.773541132745;45313.093738125055;48545.51454485481;49634.50365496371;50474.49525504772;46301.536984630395;47009.5299047012;47332.5266747335;47470.05059898852;47746.04507909822;7624.351930086005;7673.30940215361;7685.923970644002;7729.884051739341;7818.374530037469;30440;30518.542221866246;30680;30742.231444214074;31269.687303127586;37737.43393849149;39379.212415752096;41543.79228103961;41563.584364157185;42164.578354216064;10239.078482936571;10462;10462.110720588835;10551.419671918118;10554.419506927192;10377.012633143424;10498;10623.256372053882;10676.46617669129;10698.518566664674;9840.803183936425;10086.041826026516;10261.127804136731;10425.374477531372;10478.476076196008;9915.355501892354;10004.899951000689;10082.747931301776;10239.795204096024;10273.897261027592;9657.420554766737;10379.740506487398;10490.737731556466;10666.89333106659;10723.571057157626;8213.83572328562;8552;8791.076936921787;9020.639174432948;9035.412698174598;8414.495130292202;8483.44857584255;8603.784905377415;9085.273178145864;9122 13:58:29 INFO - PROCESS | 3379 | __end_tp_report 13:58:29 INFO - PROCESS | 3379 | __start_cc_report 13:58:29 INFO - PROCESS | 3379 | _x_x_mozilla_cycle_collect,363 13:58:29 INFO - PROCESS | 3379 | __end_cc_report 13:58:29 INFO - PROCESS | 3379 | __startTimestamp1461790709467__endTimestamp 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | ------- Summary: start ------- 13:58:29 INFO - PROCESS | 3379 | Number of tests: 6 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | [#0] dojo.html Cycles:165 Average:4743.67 Median:4935.80 stddev:593.31 (12.0%) stddev-sans-first:571.92 13:58:29 INFO - PROCESS | 3379 | Values: 2649.0 2711.1 2717.3 2748.2 2766.0 4823.7 4839.1 4841.3 4855.1 4902.4 4717.5 4780.0 4834.4 4844.9 4886.8 4449.5 4468.6 4524.3 4527.3 4582.0 534.5 4413.4 4425.1 4508.4 4547.1 4475.9 4494.1 4499.9 4512.8 4525.8 4350.8 4560.7 4561.4 4597.7 4618.6 4372.0 4405.0 4424.5 4442.4 4446.0 4596.5 4609.0 4655.4 4658.9 4721.3 5028.5 5092.8 5103.7 5107.2 5109.0 5154.7 5176.7 5181.9 5186.9 5230.4 4791.5 4801.9 4808.9 4821.6 4842.1 5122.2 5238.9 5260.3 5261.1 5345.3 5055.1 5094.9 5095.9 5097.5 5124.7 5171.3 5180.8 5205.4 5214.0 5218.5 4928.6 5016.2 5105.9 5106.7 5118.6 4981.3 4990.9 5026.3 5036.8 5098.5 4241.7 4265.4 4266.9 4299.0 4306.9 3684.0 3748.1 3783.4 3801.4 3817.3 4506.5 4513.9 4525.0 4563.4 4572.8 5157.4 5177.3 5206.1 5208.4 5211.8 4326.2 4393.2 4474.8 4527.3 4563.7 4628.9 4651.5 4652.6 4676.4 4695.6 4973.0 4979.9 4991.7 5000.3 5001.5 5051.4 5221.6 5224.7 5299.0 5314.0 4950.6 4971.2 4978.3 4983.8 5028.5 5112.1 5114.2 5114.7 5117.2 5121.2 4973.9 5093.8 5204.6 5229.5 5256.9 4949.5 4950.9 4993.3 4996.2 5043.3 4935.8 4979.5 4981.3 4994.2 4996.0 4792.7 4844.9 4914.5 4919.7 4943.2 4991.9 5006.1 5014.6 5020.9 5062.5 4917.4 4920.4 4923.7 4936.2 4963.0 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | [#1] ext.html Cycles:180 Average:37554.78 Median:33772.66 stddev:58351.49 (172.8%) stddev-sans-first:58449.12 13:58:29 INFO - PROCESS | 3379 | Values: 575.8 594.8 617.4 617.7 635.5 33168.8 34154.1 34304.8 34321.0 34401.7 34597.8 35659.6 35843.1 35874.3 35900.3 7501.1 7664.2 7690.2 7718.8 7730.0 7530.1 7638.4 7674.4 7889.9 7900.0 7858.3 7903.0 7925.0 7926.2 7958.4 7801.3 7821.0 7855.0 7860.2 7866.7 7779.4 7814.3 7834.5 7871.3 7877.7 35768.6 35835.5 36208.6 36237.5 36350.3 2352.8 2944.1 2996.3 3046.5 3469.9 25241.7 25531.9 25801.7 25853.7 25972.4 3286.3 3312.1 3338.4 3409.9 3427.4 153688.0 153792.0 154189.0 154544.2 154933.0 48190.8 48848.8 48853.0 48963.3 49136.3 47764.0 48913.5 49156.8 49166.8 52193.7 13937.7 14076.2 14132.8 14146.3 14168.4 11473.3 11498.9 11545.5 11570.7 11616.6 16860.7 17350.9 17393.1 17432.8 17563.0 6701.6 6971.3 7012.1 7044.8 7163.8 862.5 952.6 955.5 986.6 1064.7 25065.6 25570.7 25793.5 25828.5 25928.7 988.5 1005.7 1051.0 1072.6 1073.3 13492.1 13633.7 13710.0 13887.2 14221.5 258408.0 260941.0 261343.0 263279.0 264049.0 45099.8 45465.8 45817.5 45843.3 45959.3 1202.6 1233.1 1235.7 1245.4 1269.1 24167.5 25472.0 26390.3 26460.3 26543.2 39535.4 39952.4 40269.6 40298.8 40315.6 240103.0 241215.0 241315.0 241687.0 241804.0 23737.8 23854.8 24233.0 24649.9 24663.1 39415.4 39441.6 39603.6 39608.0 40242.0 33443.2 33460.8 33751.8 34660.8 35105.3 33035.7 33793.5 33796.2 33908.2 34347.3 26622.9 31212.4 31830.2 33395.5 33948.7 28099.0 28124.2 28202.0 28351.3 28516.7 23478.0 23689.8 23798.3 24114.3 24124.4 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | [#2] jquery.html Cycles:180 Average:20625.35 Median:187740.94 stddev:49933.49 (26.6%) stddev-sans-first:50050.41 13:58:29 INFO - PROCESS | 3379 | Values: 371.0 372.1 374.3 375.9 387.3 15240.4 15774.1 16693.6 16719.2 16921.9 15678.2 15932.3 16458.4 16515.2 16568.2 4968.0 5099.4 5100.5 5144.5 5146.6 3666.8 5058.3 5568.0 5862.9 5879.1 5784.8 5817.6 5824.8 5837.4 5840.2 5652.5 5891.9 5920.5 5921.0 5922.1 4835.4 5192.7 5203.1 5204.4 5213.8 12046.2 12161.7 12186.8 12223.7 12283.6 1762.4 1852.4 1876.9 1879.4 1930.9 8646.3 9050.7 9357.6 9409.7 9480.1 1729.8 1748.7 1791.8 1830.8 1855.4 48378.3 60427.7 61597.4 61723.7 62146.4 9055.2 9581.8 9610.2 10141.4 10226.8 13677.8 13688.3 13779.8 13780.1 13835.9 7200.9 7426.5 7471.9 7535.0 7561.7 6995.9 7099.4 7176.1 7193.6 7250.5 4264.3 4380.5 4395.0 4459.4 4464.5 1682.3 1774.2 1820.9 1845.9 1879.5 852.3 885.3 921.6 933.0 936.8 14502.6 15355.8 15616.4 15891.0 16382.0 887.6 907.6 911.3 933.1 933.7 9005.7 9120.6 9248.1 9406.7 9430.8 249378.0 249525.0 251903.0 356655.0 375106.0 44849.3 46719.9 71250.6 72441.3 76038.6 918.4 918.9 963.7 964.0 975.8 14296.7 14302.8 14508.3 14604.6 14928.2 32435.0 32645.5 32646.0 34291.5 36438.5 43600.3 44820.8 45577.0 46220.5 46528.8 10831.4 10975.9 10991.8 11066.3 11093.7 8466.7 9506.6 11720.6 12109.9 12177.1 9913.5 9966.0 9990.5 10168.3 10287.5 10037.2 10156.8 10328.6 10430.2 10631.7 10210.9 10219.8 10355.8 10611.8 10680.4 10905.6 10930.1 10999.6 11001.5 11148.2 10789.1 10911.2 10927.8 10966.1 10969.3 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | [#3] mootools.html Cycles:180 Average:4998.73 Median:5322.21 stddev:2682.17 (50.4%) stddev-sans-first:2676.20 13:58:29 INFO - PROCESS | 3379 | Values: 1418.4 1488.0 1552.6 1702.6 1758.8 6477.7 7013.9 7059.3 7351.6 7363.3 7205.5 7293.0 7362.5 7377.2 7378.4 2210.4 2233.6 2242.8 2247.1 2248.2 2122.0 2129.0 2184.5 2184.9 2187.8 2232.2 2239.9 2245.0 2251.8 2263.6 2157.5 2158.7 2163.3 2182.6 2185.6 2163.2 2186.7 2187.1 2212.5 2223.3 7346.7 7361.9 7443.3 7450.2 7453.8 4520.2 4584.3 4613.1 4627.5 4653.9 2895.0 3058.4 3074.9 3083.7 3109.9 953.5 955.4 981.4 1004.8 1013.2 9569.2 9741.9 9794.2 9821.1 9862.0 4231.8 4328.2 4364.0 4370.2 4370.7 8524.4 8578.6 8595.6 8627.4 8627.7 4656.5 4704.8 4713.4 4728.7 4736.3 3679.2 4160.5 4174.2 4226.0 4280.1 3616.3 3647.0 3699.2 3749.6 3756.8 1260.7 1279.0 1285.3 1294.0 1294.3 790.2 895.6 897.1 913.3 933.7 5223.8 5347.8 5350.5 5479.9 5550.6 423.9 435.0 435.8 447.4 448.0 3641.2 3678.1 3703.2 3762.5 3765.9 8767.3 9162.1 9175.7 9258.8 9283.3 9099.8 9236.6 9240.2 9250.2 9284.3 7052.3 7056.2 7114.6 7187.3 7220.2 5170.8 5295.2 5296.6 5395.2 5446.5 8579.7 8596.7 8607.9 8625.5 8660.2 8471.3 8654.0 8726.2 8827.3 8879.0 5609.9 6267.9 6291.8 6515.5 6615.7 6892.3 6962.4 7024.6 7039.1 7057.9 6411.0 6579.0 6583.4 6617.5 6671.5 6336.3 6480.5 6494.2 6521.7 6565.4 6342.4 6358.7 6384.3 6413.9 6418.3 4436.4 4532.9 4592.2 4631.2 4660.7 4637.2 4654.4 4658.7 4659.6 4728.1 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | [#4] prototype.html Cycles:180 Average:4390.41 Median:4960.45 stddev:1298.65 (26.2%) stddev-sans-first:1265.24 13:58:29 INFO - PROCESS | 3379 | Values: 286.4 301.7 302.6 305.9 308.8 4771.9 4830.9 4880.0 4957.9 5002.6 4916.1 4963.0 4972.3 4987.0 5007.5 3888.5 3915.4 3930.8 3934.7 3947.9 3666.6 3920.9 3936.3 3948.3 3953.0 3817.5 3823.4 3854.3 3857.1 3859.9 3822.8 3842.1 3842.8 3842.9 3856.6 3374.9 3375.7 3376.9 3380.8 3386.3 4616.1 4739.8 4771.1 4771.9 4779.2 4312.6 4318.4 4345.9 4350.2 4358.8 5133.7 5145.7 5161.9 5167.4 5168.3 3564.3 3597.9 3634.3 3667.9 3670.5 5356.0 5365.2 5434.0 5437.2 5449.9 3718.6 3723.3 3728.3 3745.7 3754.6 3770.1 3794.9 3803.4 3806.8 3825.4 4074.2 4325.4 4337.0 4350.7 4357.6 5185.9 5199.0 5213.2 5226.9 5230.5 1295.3 1333.2 1373.6 1375.2 1378.1 899.6 913.0 918.7 919.1 934.6 4809.4 4837.3 4869.2 4871.0 4878.9 5592.4 5644.1 5689.6 5692.5 5695.7 4743.6 4809.2 4819.6 4826.9 4847.3 2985.0 3012.3 3038.0 3042.3 3045.6 5363.2 5395.9 5410.9 5416.8 5427.2 5595.6 5681.1 5764.8 5776.3 5786.5 5358.4 5370.4 5379.3 5389.7 5402.6 5521.5 5602.8 5639.8 5651.3 5660.5 5474.3 5483.9 5526.9 5539.8 5541.5 5349.6 5375.1 5384.2 5405.2 5440.2 3533.9 3905.8 3907.8 3911.9 3912.6 5066.3 5321.4 5338.2 5369.9 5373.6 5018.2 5195.4 5232.2 5246.8 5249.9 5111.5 5226.4 5228.3 5233.5 5260.5 4867.6 5130.3 5138.8 5166.7 5177.9 5287.0 5288.3 5290.3 5300.9 5304.6 5152.4 5153.5 5153.9 5177.8 5193.2 13:58:29 INFO - PROCESS | 3379 | 13:58:29 INFO - PROCESS | 3379 | [#5] yui.html Cycles:180 Average:13003.81 Median:48164.90 stddev:15109.20 (31.4%) stddev-sans-first:15123.26 13:58:29 INFO - PROCESS | 3379 | Values: 683.2 686.6 716.5 742.6 746.9 11563.5 11591.1 11804.6 12994.0 13498.6 13050.9 13092.3 13144.7 13184.5 13280.8 636.8 811.6 820.2 820.8 820.9 792.3 817.4 821.2 824.0 826.3 855.2 862.6 865.4 868.6 869.2 856.4 859.4 864.1 866.4 866.5 629.4 631.3 632.7 634.3 634.8 13037.9 13098.7 13110.9 13118.9 13124.3 12688.7 12806.6 12814.5 12818.2 13113.0 9848.1 9888.5 9909.2 9979.0 10173.4 3092.2 3111.4 3120.7 3173.7 3199.8 47603.6 47604.8 47935.3 48394.5 48593.0 9964.4 9972.6 9981.0 10074.7 10191.3 15970.7 18021.7 18100.8 18125.7 18149.1 6758.6 6828.1 6884.3 6968.5 6982.1 3749.2 3813.8 3848.7 3915.9 3926.8 2894.7 2954.9 2988.7 3094.7 3095.5 570.9 577.8 580.1 583.1 586.6 550.5 580.7 663.8 665.8 672.2 8114.6 8298.4 8302.1 8333.7 8551.3 445.4 532.9 569.0 624.7 666.7 3549.8 3754.3 3807.2 3827.7 3915.4 51722.2 51767.2 52804.2 53024.0 53178.5 45291.8 45313.1 48545.5 49634.5 50474.5 46301.5 47009.5 47332.5 47470.1 47746.0 7624.4 7673.3 7685.9 7729.9 7818.4 30440.0 30518.5 30680.0 30742.2 31269.7 37737.4 39379.2 41543.8 41563.6 42164.6 10239.1 10462.0 10462.1 10551.4 10554.4 10377.0 10498.0 10623.3 10676.5 10698.5 9840.8 10086.0 10261.1 10425.4 10478.5 9915.4 10004.9 10082.7 10239.8 10273.9 9657.4 10379.7 10490.7 10666.9 10723.6 8213.8 8552.0 8791.1 9020.6 9035.4 8414.5 8483.4 8603.8 9085.3 9122.0 13:58:29 INFO - PROCESS | 3379 | -------- Summary: end -------- 13:58:29 INFO - PROCESS | 3379 | 13:58:30 INFO - TEST-INFO | 3379: exit 0 13:58:30 INFO - TEST-OK | dromaeo_css | took 1115561ms 13:58:30 INFO - TEST-START | kraken 13:58:30 INFO - operating with platform_type : linux_ 13:58:30 INFO - Initialising browser for kraken test... 13:58:30 INFO - TEST-INFO | started process 3608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpacGoVd/profile http://localhost:41860/getInfo.html) 13:58:34 INFO - PROCESS | 3608 | 13:58:34 INFO - PROCESS | 3608 | (process:3674): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:58:34 INFO - PROCESS | 3608 | __metrics Screen width/height:1600/1200 13:58:34 INFO - PROCESS | 3608 | colorDepth:24 13:58:34 INFO - PROCESS | 3608 | Browser inner width/height: 1024/697 13:58:34 INFO - PROCESS | 3608 | __metrics 13:58:35 ERROR - PROCESS | 3608 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:58:36 INFO - TEST-INFO | 3608: exit 0 13:58:36 INFO - Browser initialized. 13:58:36 INFO - Running cycle 1/1 for kraken test... 13:58:36 INFO - TEST-INFO | started process 3725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpacGoVd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:38 INFO - PROCESS | 3725 | 13:58:38 INFO - PROCESS | 3725 | (process:3786): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:58:48 INFO - PROCESS | 3725 | RSS: Main: 165806080 13:58:48 INFO - PROCESS | 3725 | 13:58:50 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-beat-detection) 13:58:51 INFO - PROCESS | 3725 | RSS: Main: 170340352 13:58:51 INFO - PROCESS | 3725 | 13:58:54 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-dft) 13:58:55 INFO - PROCESS | 3725 | RSS: Main: 174018560 13:58:55 INFO - PROCESS | 3725 | 13:58:58 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-fft) 13:58:59 INFO - PROCESS | 3725 | RSS: Main: 164413440 13:58:59 INFO - PROCESS | 3725 | 13:59:01 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41860/tests/kraken/driver.html?testName=audio-oscillator) 13:59:01 INFO - PROCESS | 3725 | RSS: Main: 165048320 13:59:01 INFO - PROCESS | 3725 | 13:59:04 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:59:04 INFO - PROCESS | 3725 | RSS: Main: 166248448 13:59:04 INFO - PROCESS | 3725 | 13:59:07 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41860/tests/kraken/driver.html?testName=imaging-darkroom) 13:59:08 INFO - PROCESS | 3725 | RSS: Main: 166584320 13:59:08 INFO - PROCESS | 3725 | 13:59:11 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41860/tests/kraken/driver.html?testName=imaging-desaturate) 13:59:12 INFO - PROCESS | 3725 | RSS: Main: 166113280 13:59:12 INFO - PROCESS | 3725 | 13:59:15 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41860/tests/kraken/driver.html?testName=json-parse-financial) 13:59:16 INFO - PROCESS | 3725 | RSS: Main: 166719488 13:59:16 INFO - PROCESS | 3725 | 13:59:17 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:18 INFO - PROCESS | 3725 | RSS: Main: 167006208 13:59:18 INFO - PROCESS | 3725 | 13:59:20 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:21 INFO - PROCESS | 3725 | RSS: Main: 166928384 13:59:21 INFO - PROCESS | 3725 | 13:59:23 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:23 INFO - PROCESS | 3725 | RSS: Main: 167825408 13:59:23 INFO - PROCESS | 3725 | 13:59:26 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:27 INFO - PROCESS | 3725 | RSS: Main: 167956480 13:59:27 INFO - PROCESS | 3725 | 13:59:30 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:31 INFO - PROCESS | 3725 | RSS: Main: 165007360 13:59:31 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | Cycle 1(1): loaded http://localhost:41860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41860/tests/kraken/driver.html?testName=ai-astar) 13:59:33 INFO - PROCESS | 3725 | RSS: Main: 166895616 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | __start_tp_report 13:59:33 INFO - PROCESS | 3725 | _x_x_mozilla_page_load 13:59:33 INFO - PROCESS | 3725 | _x_x_mozilla_page_load_details 13:59:33 INFO - PROCESS | 3725 | |i|pagename|runs| 13:59:33 INFO - PROCESS | 3725 | |0;ai-astar;116;108;112;112;113;127;113;112;114;113 13:59:33 INFO - PROCESS | 3725 | |1;audio-beat-detection;155;132;176;181;136;158;163;134;186;134 13:59:33 INFO - PROCESS | 3725 | |2;audio-dft;160;163;165;175;162;166;161;162;166;161 13:59:33 INFO - PROCESS | 3725 | |3;audio-fft;77;77;74;166;75;74;74;73;166;78 13:59:33 INFO - PROCESS | 3725 | |4;audio-oscillator;94;94;148;95;94;95;149;95;94;151 13:59:33 INFO - PROCESS | 3725 | |5;imaging-gaussian-blur;118;117;118;118;117;118;118;118;119;117 13:59:33 INFO - PROCESS | 3725 | |6;imaging-darkroom;147;147;147;147;149;148;148;148;146;149 13:59:33 INFO - PROCESS | 3725 | |7;imaging-desaturate;95;96;95;97;95;95;96;96;95;95 13:59:33 INFO - PROCESS | 3725 | |8;json-parse-financial;63;63;65;64;64;65;72;77;62;69 13:59:33 INFO - PROCESS | 3725 | |9;json-stringify-tinderbox;65;64;65;66;65;64;65;64;64;72 13:59:33 INFO - PROCESS | 3725 | |10;stanford-crypto-aes;87;78;80;79;82;81;82;89;82;79 13:59:33 INFO - PROCESS | 3725 | |11;stanford-crypto-ccm;136;140;134;135;145;134;134;134;175;138 13:59:33 INFO - PROCESS | 3725 | |12;stanford-crypto-pbkdf2;222;217;217;219;222;217;220;219;225;227 13:59:33 INFO - PROCESS | 3725 | |13;stanford-crypto-sha256-iterative;78;78;76;78;76;78;74;76;76;75 13:59:33 INFO - PROCESS | 3725 | __end_tp_report 13:59:33 INFO - PROCESS | 3725 | __start_cc_report 13:59:33 INFO - PROCESS | 3725 | _x_x_mozilla_cycle_collect,922 13:59:33 INFO - PROCESS | 3725 | __end_cc_report 13:59:33 INFO - PROCESS | 3725 | __startTimestamp1461790773539__endTimestamp 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | ------- Summary: start ------- 13:59:33 INFO - PROCESS | 3725 | Number of tests: 14 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.99 (4.4%) stddev-sans-first:5.24 13:59:33 INFO - PROCESS | 3725 | Values: 116.0 108.0 112.0 112.0 113.0 127.0 113.0 112.0 114.0 113.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:160.50 stddev:20.87 (13.0%) stddev-sans-first:22.14 13:59:33 INFO - PROCESS | 3725 | Values: 155.0 132.0 176.0 181.0 136.0 158.0 163.0 134.0 186.0 134.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:4.38 (2.7%) stddev-sans-first:4.39 13:59:33 INFO - PROCESS | 3725 | Values: 160.0 163.0 165.0 175.0 162.0 166.0 161.0 162.0 166.0 161.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#3] audio-fft Cycles:10 Average:93.40 Median:74.50 stddev:38.30 (51.4%) stddev-sans-first:40.16 13:59:33 INFO - PROCESS | 3725 | Values: 77.0 77.0 74.0 166.0 75.0 74.0 74.0 73.0 166.0 78.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.00 stddev:26.53 (28.2%) stddev-sans-first:27.43 13:59:33 INFO - PROCESS | 3725 | Values: 94.0 94.0 148.0 95.0 94.0 95.0 149.0 95.0 94.0 151.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:59:33 INFO - PROCESS | 3725 | Values: 118.0 117.0 118.0 118.0 117.0 118.0 118.0 118.0 119.0 117.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 13:59:33 INFO - PROCESS | 3725 | Values: 147.0 147.0 147.0 147.0 149.0 148.0 148.0 148.0 146.0 149.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 13:59:33 INFO - PROCESS | 3725 | Values: 95.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 95.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.00 stddev:4.81 (7.4%) stddev-sans-first:4.94 13:59:33 INFO - PROCESS | 3725 | Values: 63.0 63.0 65.0 64.0 64.0 65.0 72.0 77.0 62.0 69.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 13:59:33 INFO - PROCESS | 3725 | Values: 65.0 64.0 65.0 66.0 65.0 64.0 65.0 64.0 64.0 72.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:3.54 (4.3%) stddev-sans-first:3.24 13:59:33 INFO - PROCESS | 3725 | Values: 87.0 78.0 80.0 79.0 82.0 81.0 82.0 89.0 82.0 79.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:137.00 stddev:12.63 (9.2%) stddev-sans-first:13.29 13:59:33 INFO - PROCESS | 3725 | Values: 136.0 140.0 134.0 135.0 145.0 134.0 134.0 134.0 175.0 138.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:220.50 Median:221.00 stddev:3.47 (1.6%) stddev-sans-first:3.64 13:59:33 INFO - PROCESS | 3725 | Values: 222.0 217.0 217.0 219.0 222.0 217.0 220.0 219.0 225.0 227.0 13:59:33 INFO - PROCESS | 3725 | 13:59:33 INFO - PROCESS | 3725 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:77.00 stddev:1.43 (1.9%) stddev-sans-first:1.41 13:59:33 INFO - PROCESS | 3725 | Values: 78.0 78.0 76.0 78.0 76.0 78.0 74.0 76.0 76.0 75.0 13:59:33 INFO - PROCESS | 3725 | -------- Summary: end -------- 13:59:33 INFO - PROCESS | 3725 | 13:59:34 INFO - TEST-INFO | 3725: exit 0 13:59:34 INFO - TEST-OK | kraken | took 64339ms 13:59:34 INFO - SUITE-END | took 1179s 13:59:34 INFO - Completed test suite (00:19:40) 13:59:34 INFO - javascript benchmark 13:59:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.0, 2711.051132103764, 2717.2935036890403, 2748.1755473358, 2765.95851062234, 4823.662343635947, 4839.05638400512, 4841.346418233542, 4855.053264613402, 4902.362692849929, 4717.504662010491, 4780.0, 4834.444038935523, 4844.878878028051, 4886.780094895729, 4449.466064072316, 4468.5754853289045, 4524.34397012433, 4527.253003254459, 4581.954180458186, 534.5279845446645, 4413.3821265022925, 4425.114977004596, 4508.39136716544, 4547.113312903985, 4475.932861007088, 4494.07871386365, 4499.932501012488, 4512.819487220508, 4525.818967241306, 4350.782460876943, 4560.726356418625, 4561.40701708779, 4597.70114942531, 4618.5843274105155, 4371.956280437218, 4405.0, 4424.469063712343, 4442.355858400546, 4445.977770111129, 4596.471405788344, 4608.976955115203, 4655.441347038343, 4658.930116048262, 4721.315409265637, 5028.522290382408, 5092.8472145835685, 5103.744812759384, 5107.157319042353, 5109.029284435946, 5154.664946778447, 5176.6893986360565, 5181.922271165936, 5186.948130518685, 5230.424653288135, 4791.472937976785, 4801.927971080437, 4808.8797780055775, 4821.614270858393, 4842.080004799112, 5122.206058061007, 5238.92141617876, 5260.28986086881, 5261.13191323435, 5345.278387417727, 5055.09008378488, 5094.923576146361, 5095.949040509621, 5097.515736005073, 5124.718140502234, 5171.276021357013, 5180.844574662766, 5205.427402985669, 5213.973930130325, 5218.530332270114, 4928.605711543068, 5016.2224855147515, 5105.9489405106215, 5106.719130447861, 5118.564921981673, 4981.302617633534, 4990.850274491771, 5026.29631851541, 5036.84889453317, 5098.5411312982005, 4241.681873859473, 4265.424167737316, 4266.935995960063, 4298.990706505459, 4306.870793876126, 3684.0421490412687, 3748.11919198988, 3783.39465685489, 3801.4107813288983, 3817.255635151119, 4506.504284528699, 4513.909721805546, 4525.0, 4563.429571303587, 4572.817087316536, 5157.381114266312, 5177.326947496801, 5206.140986737221, 5208.374995000624, 5211.791528338824, 4326.17802617508, 4393.20922234001, 4474.843380481732, 4527.275635898241, 4563.680542362003, 4628.907421851544, 4651.511591282867, 4652.604528615106, 4676.3686902267755, 4695.577398034194, 4972.950270497321, 4979.875503112451, 4991.650584459053, 5000.274960130833, 5001.499850015042, 5051.368578927634, 5221.608379371486, 5224.660397074178, 5298.97350513245, 5314.0, 4950.554450099508, 4971.229459433794, 4978.303037574815, 4983.825566105169, 5028.497150284942, 5112.130937740668, 5114.15616423286, 5114.693118412758, 5117.181250999822, 5121.1550094234035, 4973.900521989613, 5093.847184584469, 5204.557612602971, 5229.450907654794, 5256.921146182887, 4949.505049495022, 4950.900981980412, 4993.251012348177, 4996.225585034325, 5043.2939388486375, 4935.802567897387, 4979.477154898828, 4981.277714731271, 4994.175960966545, 4996.0, 4792.664513484023, 4844.854654360375, 4914.459409464885, 4919.729414882073, 4943.184374578154, 4991.925121123259, 5006.07387633289, 5014.598832093497, 5020.924686129638, 5062.544371006627, 4917.360743103373, 4920.40955085392, 4923.704577725348, 4936.185529387611, 4963.03220871941], "value": 4708.661066707489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7898367096011, 594.7531774313659, 617.4288782875839, 617.6880675258993, 635.4852569418774, 33168.834155829216, 34154.14614634632, 34304.82847585765, 34321.0, 34401.65598344022, 34597.82701086491, 35659.643403565955, 35843.103922401955, 35874.282514349696, 35900.2819943601, 7501.099868015832, 7664.156942736295, 7690.230976902321, 7718.807029824243, 7730.0, 7530.134034586038, 7638.427117966147, 7674.424418168632, 7889.8816517752275, 7900.0, 7858.29275365217, 7902.960485197595, 7925.0, 7926.207379262085, 7958.4031197660115, 7801.297883190512, 7820.960895195488, 7855.0, 7860.213978602123, 7866.724664636738, 7779.37764978806, 7814.3357814585825, 7834.451588388815, 7871.330936870373, 7877.724279650242, 35768.64231357679, 35835.462468063, 36208.63791362079, 36237.45643815345, 36350.27299453996, 2352.800011998982, 2944.1167649705003, 2996.340805022913, 3046.482098043316, 3469.9479507807405, 25241.747582524124, 25531.872340638365, 25801.741982580308, 25853.74146258532, 25972.35069123268, 3286.3263031078573, 3312.1222875937897, 3338.4491558892755, 3409.931801363959, 3427.417339052367, 153688.0, 153792.0, 154189.0, 154544.227278864, 154933.0, 48190.75904620454, 48848.75575622099, 48853.0, 48963.26555101676, 49136.26295605569, 47764.0, 48913.51086489089, 49156.75421622869, 49166.75416622966, 52193.7390313046, 13937.721245575032, 14076.225807580477, 14132.788008179885, 14146.29268536569, 14168.362423690958, 11473.311601303782, 11498.94250528742, 11545.48045337945, 11570.710732231593, 11616.593419230287, 16860.74708879368, 17350.91324543369, 17393.130343482775, 17432.82567174312, 17563.0, 6701.564398314094, 6971.268016858258, 7012.123484564429, 7044.788656340318, 7163.820904477326, 862.4782006885869, 952.5614427066731, 955.5174636808506, 986.6004268271362, 1064.7018834726289, 25065.62401563978, 25570.744292556836, 25793.484130317665, 25828.48343033129, 25928.740712592633, 988.5452691761726, 1005.6731562242154, 1050.9962985348973, 1072.6084978982772, 1073.3345325897837, 13492.12301200419, 13633.659158521117, 13710.0, 13887.236202008784, 14221.502247421291, 258408.0, 260941.0, 261343.0, 263279.0, 264049.0, 45099.774501127285, 45465.77267113709, 45817.541824582, 45843.31235031477, 45959.31061034087, 1202.6091520255952, 1233.0751936047784, 1235.7096082420624, 1245.40843099527, 1269.149669721289, 24167.532779021793, 25472.032599088026, 26390.340241493348, 26460.338491537095, 26543.203703888914, 39535.406968896066, 39952.40071398873, 40269.59730402658, 40298.79850600728, 40315.596844031184, 240103.0, 241215.0, 241315.0, 241687.0, 241804.0, 23737.762622373557, 23854.761452385254, 24233.0, 24649.87675061613, 24663.136790212975, 39415.408768867914, 39441.60558394379, 39603.60396395999, 39608.0, 40242.0, 33443.163920902174, 33460.83269583636, 33751.83124084462, 34660.82669586636, 35105.29789404249, 33035.669643303256, 33793.49309760307, 33796.15509612181, 33908.15229619279, 34347.31305373828, 26622.866885665448, 31212.375752484368, 31830.180378354744, 33395.499067514495, 33948.66051339455, 28099.0, 28124.156275311772, 28202.0, 28351.29121771972, 28516.716747746817, 23478.0, 23689.763102368757, 23798.286051418487, 24114.276571702878, 24124.396890077187], "value": 16302.955466185556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.0038546502642, 372.14963807699405, 374.2720408804874, 375.8853549667351, 387.30865405251615, 15240.390384384626, 15774.132422716746, 16693.582660433494, 16719.164041797907, 16921.915390423062, 15678.216089195552, 15932.283047262872, 16458.423955161572, 16515.174241287947, 16568.17159142041, 4967.950320496794, 5099.36257967754, 5100.489951004907, 5144.4598317176715, 5146.588272938156, 3666.779993200403, 5058.317127187819, 5568.0, 5862.853428664275, 5879.1475236090955, 5784.826455206329, 5817.621854579439, 5824.767009319622, 5837.357890632027, 5840.211571437865, 5652.463016013472, 5891.941080589225, 5920.4671579557835, 5920.97039514804, 5922.082077278029, 4835.419749630032, 5192.71440070796, 5203.14148165556, 5204.42751297357, 5213.843584692465, 12046.15676902617, 12161.695957601043, 12186.75626487474, 12223.69440763979, 12283.631491055283, 1762.365548402574, 1852.351676913083, 1876.9343072992517, 1879.4455635587399, 1930.94207173785, 8646.308295336357, 9050.683226087122, 9357.625694972194, 9409.717708468688, 9480.146786789222, 1729.7578339032546, 1748.6852366574012, 1791.811859754733, 1830.752848365467, 1855.3691744806831, 48378.27432588479, 60427.69786151085, 61597.38402615961, 61723.691381543256, 62146.37853621451, 9055.23030542398, 9581.760455988657, 9610.183134433511, 10141.391516508886, 10226.795464090677, 13677.794833077513, 13688.315584220949, 13779.793303100461, 13780.10429322091, 13835.861641383457, 7200.891986620205, 7426.480146389809, 7471.925280747123, 7535.0, 7561.697532098655, 6995.93004069963, 7099.36105750485, 7176.067111275501, 7193.604351760599, 7250.492465527363, 4264.296391095497, 4380.452443444569, 4394.978025109854, 4459.375687403766, 4464.549021568004, 1682.2513981278457, 1774.157275294225, 1820.8816426932208, 1845.9446216613524, 1879.5489082620072, 852.3181454836106, 885.274075258282, 921.6221349246911, 932.9533523323943, 936.7939053408239, 14502.564923052325, 15355.846441535665, 15616.3753449863, 15890.9670871393, 16382.0, 887.5961437545901, 907.6414816147585, 911.2800887299092, 933.1228645073609, 933.6545478172984, 9005.729828105168, 9120.58957346921, 9248.121428464285, 9406.71779846592, 9430.764230894283, 249378.0, 249525.0, 251903.0, 356655.0, 375106.0, 44849.32726009112, 46719.87754209501, 71250.64374678093, 72441.27558724451, 76038.6198069006, 918.4443411735804, 918.8759517465056, 963.6964356227766, 964.0, 975.7658162041059, 14296.714065718419, 14302.785458217926, 14508.274586270856, 14604.634884127558, 14928.178950157846, 32435.0, 32645.510317344782, 32646.020619381456, 34291.4856277161, 36438.453423198145, 43600.34599481074, 44820.77589612162, 45577.0, 46220.537794621625, 46528.767356163, 10831.350118992885, 10975.945120274668, 10991.835122473009, 11066.28069175501, 11093.667189984313, 8466.74599762008, 9506.57401389797, 11720.589779357682, 12109.939450302692, 12177.086718495972, 9913.504324783877, 9965.950170249393, 9990.450525221182, 10168.28821982454, 10287.53706083213, 10037.197024237897, 10156.79686406253, 10328.586856525655, 10430.16558675289, 10631.734206644896, 10210.948945255226, 10219.795604087727, 10355.844662330222, 10611.787764244826, 10680.412577308323, 10905.563777448813, 10930.125589952944, 10999.560017599206, 11001.504932277907, 11148.219624626197, 10789.136869050613, 10911.236213464981, 10927.781444371227, 10966.122710183006, 10969.286996345212], "value": 8050.829733917598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.3900922603284, 1488.0030379645636, 1552.6244845386564, 1702.6084000679837, 1758.7625670534483, 6477.708503117359, 7013.89479157813, 7059.3293637104525, 7351.595662238575, 7363.337299643031, 7205.531640443381, 7293.0, 7362.527494501094, 7377.2253913339, 7378.372838308736, 2210.403191138392, 2233.597952368573, 2242.7757224277525, 2247.067467001201, 2248.190651365507, 2122.0238690202527, 2128.9574208515896, 2184.530325979914, 2184.868907865533, 2187.835912306575, 2232.2410380470637, 2239.9216027439043, 2245.0, 2251.763564825694, 2263.60386932287, 2157.5253444242244, 2158.665406861931, 2163.2536774812665, 2182.6289530779727, 2185.606590813653, 2163.1888041984257, 2186.6719992001326, 2187.103287652055, 2212.54642798226, 2223.2774348336857, 7346.669399877019, 7361.889571656429, 7443.255674432514, 7450.18048014718, 7453.776386708408, 4520.186366454037, 4584.289435137559, 4613.054323863634, 4627.514111018329, 4653.906921861578, 2895.0139240132557, 3058.4189004089153, 3074.8616312266004, 3083.691630836921, 3109.9067027989195, 953.4517652349857, 955.44106697582, 981.3572110267786, 1004.7689031522791, 1013.1692012549712, 9569.234461243084, 9741.853872191923, 9794.16749576287, 9821.066998635119, 9861.950690246504, 4231.830726770895, 4328.199283132631, 4363.978180109143, 4370.169667763115, 4370.67219958498, 8524.445911015764, 8578.613962371708, 8595.613197406132, 8627.439216451035, 8627.741167764978, 4656.464506581787, 4704.788284527204, 4713.434387873409, 4728.71627702339, 4736.289556566474, 3679.19057807282, 4160.521540022875, 4174.186033723395, 4226.0, 4280.058387154821, 3616.349057169682, 3646.9635303647156, 3699.241655460678, 3749.5500539934837, 3756.7745935243975, 1260.703734622363, 1278.961631151067, 1285.3123578885438, 1294.0294778915813, 1294.2622705058027, 790.2453157234827, 895.5969813583913, 897.0849733272156, 913.3332667153015, 933.659214386744, 5223.817166399158, 5347.812826551052, 5350.5184533392185, 5479.945200548023, 5550.639208451437, 423.93429018502184, 434.97825108744433, 435.76686472736935, 447.40495141461776, 448.0143683895443, 3641.1625326175126, 3678.1172518595345, 3703.203811180555, 3762.5108735864164, 3765.9058523536582, 8767.342449316327, 9162.083791620784, 9175.724728258163, 9258.768530786649, 9283.303752218475, 9099.81800363989, 9236.630534778533, 9240.21458176049, 9250.167484926389, 9284.25725941923, 7052.294770522906, 7056.15326160864, 7114.608696521637, 7187.281271872771, 7220.169680486706, 5170.784865556667, 5295.232191332312, 5296.602754793329, 5395.24466574672, 5446.509814116748, 8579.699710510102, 8596.699115530926, 8607.913920860712, 8625.525596092024, 8660.220580147818, 8471.32229421657, 8654.0, 8726.214640682369, 8827.337949653931, 8878.95560522219, 5609.88780224385, 6267.9373206267355, 6291.842703932438, 6515.54391192612, 6615.66921653925, 6892.276310987274, 6962.373386395248, 7024.613646249505, 7039.084918960707, 7057.929420705727, 6410.967945160244, 6578.967105164444, 6583.407493325623, 6617.503687223381, 6671.46628269747, 6336.334684858023, 6480.513961453004, 6494.155759751202, 6521.739130434919, 6565.376289252514, 6342.39747224013, 6358.650274234961, 6384.265809431789, 6413.8717225656155, 6418.326075761977, 4436.401085853368, 4532.932006019978, 4592.196365635934, 4631.166390049689, 4660.673752837269, 4637.165310244189, 4654.4414670239785, 4658.697184682985, 4659.60393366554, 4728.0780247851335], "value": 4040.6075576755547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.3971340328607, 301.68624630384403, 302.6398585683037, 305.8944664090888, 308.81779749947555, 4771.90456190876, 4830.855074347766, 4880.023590445866, 4957.925631115536, 5002.599792016639, 4916.139675556781, 4962.975185124069, 4972.2541618757205, 4986.950130498694, 5007.549320561149, 3888.494495715553, 3915.3539665955227, 3930.764154150753, 3934.7245692801516, 3947.940780888289, 3666.5600127984544, 3920.882373528799, 3936.2717897189114, 3948.348522493785, 3952.9524675960893, 3817.4846395736636, 3823.4456003879422, 3854.3062248795204, 3857.1321452673205, 3859.9035024124482, 3822.7706337619834, 3842.058695619563, 3842.8270727817317, 3842.9423558646504, 3856.5564960029674, 3374.9156271093175, 3375.7468189885612, 3376.915577110592, 3380.780249283813, 3386.3227354529195, 4616.1229366420275, 4739.810407583693, 4771.141194584973, 4771.880702982418, 4779.211430114027, 4312.568743125694, 4318.395424640553, 4345.891352716176, 4350.216960947028, 4358.760268185249, 5133.743312834381, 5145.742712864342, 5161.896762064775, 5167.354080739908, 5168.250603662485, 3564.2592456256393, 3597.94603080954, 3634.273145370936, 3667.853285868562, 3670.504481894937, 5356.035913535562, 5365.248865158881, 5434.0, 5437.157240627709, 5449.945500545023, 3718.6281371862597, 3723.3298006359114, 3728.3289007978824, 3745.6628903398823, 3754.597057882957, 3770.132869440044, 3794.9430758538642, 3803.432682939005, 3806.8096595170687, 3825.3688141456905, 4074.246264441088, 4325.416068830667, 4336.978315108404, 4350.73895566267, 4357.564243575617, 5185.948140518622, 5198.960207958424, 5213.191955246943, 5226.869328266747, 5230.450802665741, 1295.2552282437637, 1333.2467156056796, 1373.587923622909, 1375.2229990055587, 1378.1248906944163, 899.6401439424283, 912.9634814607474, 918.673870775865, 919.0671468459519, 934.5841100710119, 4809.44691360498, 4837.306942570142, 4869.245266983623, 4870.975645121752, 4878.902421951541, 5592.384837667853, 5644.125160600113, 5689.601727879009, 5692.48767610917, 5695.7152142392715, 4743.620510359163, 4809.2305231162845, 4819.554133759858, 4826.879328016757, 4847.321375007502, 2985.000024991609, 3012.2770535071863, 3037.9544306835414, 3042.2546476113494, 3045.6040714706946, 5363.249145119687, 5395.892082158335, 5410.890767392675, 5416.83749487516, 5427.240186373911, 5595.608307418523, 5681.119426488901, 5764.798232061858, 5776.306843178845, 5786.479216870418, 5358.383785864676, 5370.409254981949, 5379.273798037293, 5389.7035663038905, 5402.648827826179, 5521.5306698931045, 5602.831915042555, 5639.802606908903, 5651.265335506358, 5660.51885589713, 5474.2609747683555, 5483.890322193613, 5526.917096243479, 5539.806106786243, 5541.5289700375915, 5349.625526213128, 5375.059364611256, 5384.21928820311, 5405.162199859028, 5440.183972404171, 3533.876314328986, 3905.8477749063527, 3907.765534067965, 3911.882643520699, 3912.5891781362548, 5066.264217322604, 5321.441248668834, 5338.1992701093595, 5369.865753356197, 5373.596980226421, 5018.2436147348135, 5195.428502864606, 5232.215167724719, 5246.842594722164, 5249.947500524946, 5111.539961403491, 5226.398964119175, 5228.320318358589, 5233.476652334888, 5260.474972013531, 4867.610591152628, 5130.333056702754, 5138.792383789882, 5166.741662916915, 5177.948220517746, 5286.9735651323035, 5288.286081378965, 5290.25936368901, 5300.920486192633, 5304.60215483848, 5152.433232344364, 5153.510416510426, 5153.922691159561, 5177.7670004849115, 5193.195054766517], "value": 3977.8112693257076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.1528904158841, 686.5640318397819, 716.5020310883934, 742.6435311050695, 746.9439792015601, 11563.479643416045, 11591.072714182867, 11804.586839460631, 12994.0, 13498.59504214875, 13050.869491305084, 13092.34538273085, 13144.671383215424, 13184.538541151062, 13280.800787988188, 636.8248731598801, 811.6063709101096, 820.2371794231362, 820.7989042684521, 820.8891799607036, 792.3106896999618, 817.448222449844, 821.2321479416735, 823.9629216685264, 826.3348004856089, 855.1832999485476, 862.5945805471418, 865.3726048614735, 868.5657171414293, 869.2437579306013, 856.4047986649313, 859.3769517100114, 864.0754392799707, 866.4324867211986, 866.4801119328415, 629.3580547841223, 631.2614241337646, 632.6710110742388, 634.3497914637487, 634.784173381048, 13037.86962130376, 13098.672533186651, 13110.934445327808, 13118.86881131186, 13124.343782810822, 12688.746225075447, 12806.551770688075, 12814.487420503168, 12818.230906145662, 13113.0, 9848.113669769684, 9888.505574721235, 9909.157721593674, 9979.0, 10173.440460774655, 3092.1805721483825, 3111.4243864884843, 3120.719135277836, 3173.7461003119697, 3199.808011519316, 47603.57189284327, 47604.7619761899, 47935.28097078547, 48394.5160548397, 48593.0, 9964.402135871871, 9972.551235194434, 9980.950095249478, 10074.69775906724, 10191.337563058378, 15970.68058638844, 18021.7296740549, 18100.818991810178, 18125.728114078298, 18149.092545372678, 6758.560693554903, 6828.146481689789, 6884.311568843075, 6968.477364197604, 6982.092327997328, 3749.1939233064477, 3813.790241536742, 3848.6536211741077, 3915.92168156641, 3926.784026878492, 2894.6526416830116, 2954.852257387165, 2988.656304524964, 3094.6905309469325, 3095.4892442747146, 570.9029464990962, 577.783331250781, 580.0718849840306, 583.12822330616, 586.6304228336121, 550.529297450682, 580.7328628830701, 663.8207683925409, 665.7869481765886, 672.2437258084655, 8114.63484143215, 8298.377621678399, 8302.086770455246, 8333.708320208763, 8551.315894728532, 445.40315976591523, 532.9413764485903, 568.9658620482784, 624.7376102037156, 666.6833254204311, 3549.751517393809, 3754.305453491113, 3807.1814559869763, 3827.7129215308964, 3915.353966595537, 51722.224166637534, 51767.22349164765, 52804.20793688098, 53024.0, 53178.46821531735, 45291.773541132745, 45313.093738125055, 48545.51454485481, 49634.50365496371, 50474.49525504772, 46301.536984630395, 47009.5299047012, 47332.5266747335, 47470.05059898852, 47746.04507909822, 7624.351930086005, 7673.30940215361, 7685.923970644002, 7729.884051739341, 7818.374530037469, 30440.0, 30518.542221866246, 30680.0, 30742.231444214074, 31269.687303127586, 37737.43393849149, 39379.212415752096, 41543.79228103961, 41563.584364157185, 42164.578354216064, 10239.078482936571, 10462.0, 10462.110720588835, 10551.419671918118, 10554.419506927192, 10377.012633143424, 10498.0, 10623.256372053882, 10676.46617669129, 10698.518566664674, 9840.803183936425, 10086.041826026516, 10261.127804136731, 10425.374477531372, 10478.476076196008, 9915.355501892354, 10004.899951000689, 10082.747931301776, 10239.795204096024, 10273.897261027592, 9657.420554766737, 10379.740506487398, 10490.737731556466, 10666.89333106659, 10723.571057157626, 8213.83572328562, 8552.0, 8791.076936921787, 9020.639174432948, 9035.412698174598, 8414.495130292202, 8483.44857584255, 8603.784905377415, 9085.273178145864, 9122.0], "value": 5964.593483792516, "unit": "score"}], "name": "dromaeo_css", "value": 6243.865064801031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 112.0, 112.0, 113.0, 127.0, 113.0, 112.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 176.0, 181.0, 136.0, 158.0, 163.0, 134.0, 186.0, 134.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 165.0, 175.0, 162.0, 166.0, 161.0, 162.0, 166.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 74.0, 166.0, 75.0, 74.0, 74.0, 73.0, 166.0, 78.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 148.0, 95.0, 94.0, 95.0, 149.0, 95.0, 94.0, 151.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 148.0, 148.0, 148.0, 146.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 64.0, 64.0, 65.0, 72.0, 77.0, 62.0, 69.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 72.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 80.0, 79.0, 82.0, 81.0, 82.0, 89.0, 82.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 134.0, 135.0, 145.0, 134.0, 134.0, 134.0, 175.0, 138.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 217.0, 217.0, 219.0, 222.0, 217.0, 220.0, 219.0, 225.0, 227.0], "value": 220.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 78.0, 76.0, 78.0, 74.0, 76.0, 76.0, 75.0], "value": 76.5, "unit": "score"}], "name": "kraken", "value": 1650.0000000000002, "alertThreshold": 2.0}]} 13:59:34 INFO - Return code: 0 13:59:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:59:34 ERROR - # TBPL SUCCESS # 13:59:34 INFO - Running post-action listener: _resource_record_post_action 13:59:34 INFO - Running post-run listener: _resource_record_post_run 13:59:35 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7811072; Write bytes: 404602880; Read time: 1244; Write time: 262764 13:59:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117411840; Read time: 0; Write time: 83804 13:59:35 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 5914624; Write bytes: 286687232; Read time: 1080; Write time: 178956 13:59:35 INFO - Running post-run listener: _upload_blobber_files 13:59:35 INFO - Blob upload gear active. 13:59:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:35 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:59:35 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:59:35 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:59:36 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:37 INFO - (blobuploader) - INFO - Done attempting. 13:59:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:59:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:37 INFO - (blobuploader) - INFO - Done attempting. 13:59:37 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:37 INFO - Return code: 0 13:59:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/507900e78bd201e241241b2fa1f3f12c11805870a217254fd4347026bb32f97d11526f6c83cdecc24259188295166119dc5992060734cba610ff891f2509ba8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30b4de5e7469b6896e5444efa1359f18dae290ab7ac0c6b01d24e51aaf4cd184a34035f68c9c4bbd676156778f3436455ceb80985d982000ca77d065f8910fc6"} 13:59:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:37 INFO - Contents: 13:59:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/507900e78bd201e241241b2fa1f3f12c11805870a217254fd4347026bb32f97d11526f6c83cdecc24259188295166119dc5992060734cba610ff891f2509ba8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30b4de5e7469b6896e5444efa1359f18dae290ab7ac0c6b01d24e51aaf4cd184a34035f68c9c4bbd676156778f3436455ceb80985d982000ca77d065f8910fc6"} 13:59:37 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:37 INFO - Copying logs to upload dir... 13:59:37 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.768263 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-04-27 13:59:37.972121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 13:59:37.975550) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911 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/507900e78bd201e241241b2fa1f3f12c11805870a217254fd4347026bb32f97d11526f6c83cdecc24259188295166119dc5992060734cba610ff891f2509ba8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30b4de5e7469b6896e5444efa1359f18dae290ab7ac0c6b01d24e51aaf4cd184a34035f68c9c4bbd676156778f3436455ceb80985d982000ca77d065f8910fc6"} build_url:https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/H6MfzFxXRk24GP1tAPGzgA/artifacts/public/build/firefox-49.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/507900e78bd201e241241b2fa1f3f12c11805870a217254fd4347026bb32f97d11526f6c83cdecc24259188295166119dc5992060734cba610ff891f2509ba8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30b4de5e7469b6896e5444efa1359f18dae290ab7ac0c6b01d24e51aaf4cd184a34035f68c9c4bbd676156778f3436455ceb80985d982000ca77d065f8910fc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 13:59:38.000836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:59:38.001229) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461788213.560310-1013634911 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004312 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 13:59:38.085826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 13:59:38.086426) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 13:59:38.086934) ========= ========= Total master_lag: 0.16 =========