builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1461635796.55 results: success (0) buildid: 20160425175058 builduid: 613edb845b2247f99e9576d6a8a40a82 revision: f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.545779) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.546220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.546525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.567783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.568094) ========= 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=0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 18:56:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.6M=0s 2016-04-25 18:56:37 (38.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.283837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.865318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.865665) ========= 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=0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.915609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:36.916002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81 --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 f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81 --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=0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 18:56:37,875 truncating revision to first 12 chars 2016-04-25 18:56:37,876 Setting DEBUG logging. 2016-04-25 18:56:37,876 attempt 1/10 2016-04-25 18:56:37,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1e0c231d7e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 18:56:38,129 unpacking tar archive at: fx-team-f1e0c231d7e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:37.450499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:37.450877) ========= script_repo_revision: f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:37.451672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:37.452007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 18:56:37.460075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-25 18:56:37.460471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:56:38 INFO - MultiFileLogger online at 20160425 18:56:38 in /builds/slave/test 18:56:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:56:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:56:38 INFO - {'append_to_log': False, 18:56:38 INFO - 'base_work_dir': '/builds/slave/test', 18:56:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:56:38 INFO - 'branch': 'Fx-Team-Non-PGO', 18:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:38 INFO - 'config_files': ('talos/linux_config.py',), 18:56:38 INFO - 'default_actions': ('clobber', 18:56:38 INFO - 'read-buildbot-config', 18:56:38 INFO - 'download-and-extract', 18:56:38 INFO - 'populate-webroot', 18:56:38 INFO - 'create-virtualenv', 18:56:38 INFO - 'install', 18:56:38 INFO - 'run-tests'), 18:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:38 INFO - 'download_minidump_stackwalk': True, 18:56:38 INFO - 'download_symbols': 'ondemand', 18:56:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:56:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:56:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:56:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:38 INFO - 'installer_path': 'installer.exe', 18:56:38 INFO - 'log_level': 'info', 18:56:38 INFO - 'log_name': 'talos', 18:56:38 INFO - 'log_to_console': True, 18:56:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:56:38 INFO - 'opt_config_files': (), 18:56:38 INFO - 'pip_index': False, 18:56:38 INFO - 'sps_profile': False, 18:56:38 INFO - 'sps_profile_interval': 0, 18:56:38 INFO - 'suite': 'dromaeojs', 18:56:38 INFO - 'system_bits': '32', 18:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:38 INFO - 'title': 'talos-linux64-ix-017', 18:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:38 INFO - 'use_talos_json': True, 18:56:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:38 INFO - 'work_dir': 'build'} 18:56:38 INFO - ##### 18:56:38 INFO - ##### Running clobber step. 18:56:38 INFO - ##### 18:56:38 INFO - Running pre-action listener: _resource_record_pre_action 18:56:38 INFO - Running main action method: clobber 18:56:38 INFO - rmtree: /builds/slave/test/build 18:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:56:38 INFO - Running post-action listener: _resource_record_post_action 18:56:38 INFO - ##### 18:56:38 INFO - ##### Running read-buildbot-config step. 18:56:38 INFO - ##### 18:56:38 INFO - Running pre-action listener: _resource_record_pre_action 18:56:38 INFO - Running main action method: read_buildbot_config 18:56:38 INFO - Using buildbot properties: 18:56:38 INFO - { 18:56:38 INFO - "project": "", 18:56:38 INFO - "product": "firefox", 18:56:38 INFO - "script_repo_revision": "production", 18:56:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:56:38 INFO - "repository": "", 18:56:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:56:38 INFO - "buildid": "20160425175058", 18:56:38 INFO - "pgo_build": "False", 18:56:38 INFO - "basedir": "/builds/slave/test", 18:56:38 INFO - "buildnumber": 1710, 18:56:38 INFO - "slavename": "talos-linux64-ix-017", 18:56:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:56:38 INFO - "platform": "ubuntu64_hw", 18:56:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:56:38 INFO - "branch": "fx-team", 18:56:38 INFO - "repo_path": "integration/fx-team", 18:56:38 INFO - "revision": "f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81", 18:56:38 INFO - "stage_platform": "linux64", 18:56:38 INFO - "builduid": "613edb845b2247f99e9576d6a8a40a82", 18:56:38 INFO - "slavebuilddir": "test" 18:56:38 INFO - } 18:56:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:56:38 INFO - Running post-action listener: _resource_record_post_action 18:56:38 INFO - ##### 18:56:38 INFO - ##### Running download-and-extract step. 18:56:38 INFO - ##### 18:56:38 INFO - Running pre-action listener: _resource_record_pre_action 18:56:38 INFO - Running main action method: download_and_extract 18:56:38 INFO - mkdir: /builds/slave/test/build/tests 18:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:38 INFO - https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:43 INFO - Downloaded 1361 bytes. 18:56:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:56:43 INFO - Using the following test package requirements: 18:56:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:56:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:56:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'jsshell-linux-x86_64.zip'], 18:56:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:56:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:56:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:56:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:56:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:56:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:56:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:56:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:56:43 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')]} 18:56:43 INFO - https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:44 INFO - Downloaded 22290132 bytes. 18:56:44 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'] 18:56:44 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 18:56:45 INFO - Return code: 0 18:56:45 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 18:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:45 INFO - https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:46 INFO - Downloaded 22290132 bytes. 18:56:46 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'] 18:56:46 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 18:56:48 INFO - Return code: 0 18:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:48 INFO - https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:49 INFO - Downloaded 10840145 bytes. 18:56:49 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'] 18:56:49 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 18:56:49 INFO - Return code: 0 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:49 INFO - https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ms77vRnCSv2oaDqbmicUrw/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 18:56:53 INFO - Downloaded 54813598 bytes. 18:56:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:56:53 INFO - mkdir: /builds/slave/test/properties 18:56:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:56:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:56:53 INFO - Contents: 18:56:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:56:54 INFO - Running post-action listener: _resource_record_post_action 18:56:54 INFO - Running post-action listener: set_extra_try_arguments 18:56:54 INFO - ##### 18:56:54 INFO - ##### Running populate-webroot step. 18:56:54 INFO - ##### 18:56:54 INFO - Running pre-action listener: _resource_record_pre_action 18:56:54 INFO - Running main action method: populate_webroot 18:56:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:56:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:56:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:56:54 INFO - '--tppagecycles', 18:56:54 INFO - '7'], 18:56:54 INFO - 'tests': ['tsvgm']}}, 18:56:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:56:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:56:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:56:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:56:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['damp', 'tps']}, 18:56:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'tests': ['damp', 'tps']}, 18:56:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['dromaeo_dom']}, 18:56:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:56:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['a11yr', 18:56:54 INFO - 'ts_paint', 18:56:54 INFO - 'tpaint', 18:56:54 INFO - 'sessionrestore', 18:56:54 INFO - 'sessionrestore_no_auto_restore', 18:56:54 INFO - 'tabpaint']}, 18:56:54 INFO - 'other-e10s': {'tests': ['a11yr', 18:56:54 INFO - 'ts_paint', 18:56:54 INFO - 'tpaint', 18:56:54 INFO - 'sessionrestore', 18:56:54 INFO - 'sessionrestore_no_auto_restore', 18:56:54 INFO - 'tabpaint']}, 18:56:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:56:54 INFO - 'ts_paint', 18:56:54 INFO - 'tpaint', 18:56:54 INFO - 'sessionrestore', 18:56:54 INFO - 'sessionrestore_no_auto_restore', 18:56:54 INFO - 'tabpaint']}, 18:56:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:56:54 INFO - 'ts_paint', 18:56:54 INFO - 'tpaint', 18:56:54 INFO - 'sessionrestore', 18:56:54 INFO - 'sessionrestore_no_auto_restore', 18:56:54 INFO - 'tabpaint']}, 18:56:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['a11yr', 18:56:54 INFO - 'ts_paint', 18:56:54 INFO - 'tpaint', 18:56:54 INFO - 'sessionrestore', 18:56:54 INFO - 'sessionrestore_no_auto_restore', 18:56:54 INFO - 'tabpaint']}, 18:56:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['a11yr', 18:56:54 INFO - 'ts_paint', 18:56:54 INFO - 'tpaint', 18:56:54 INFO - 'sessionrestore', 18:56:54 INFO - 'sessionrestore_no_auto_restore', 18:56:54 INFO - 'tabpaint']}, 18:56:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['tsvgx', 18:56:54 INFO - 'tsvgr_opacity', 18:56:54 INFO - 'tart', 18:56:54 INFO - 'tscrollx', 18:56:54 INFO - 'cart']}, 18:56:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:56:54 INFO - 'tsvgr_opacity', 18:56:54 INFO - 'tart', 18:56:54 INFO - 'tscrollx', 18:56:54 INFO - 'cart']}, 18:56:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'talos_options': ['--disable-e10s'], 18:56:54 INFO - 'tests': ['tp5o']}, 18:56:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'tests': ['tp5o']}, 18:56:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'talos_options': ['--disable-e10s', 18:56:54 INFO - '--xperf_path', 18:56:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:54 INFO - 'tests': ['tp5n']}, 18:56:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:56:54 INFO - 'talos_options': ['--xperf_path', 18:56:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:54 INFO - 'tests': ['tp5n']}}, 18:56:54 INFO - 'talos.zip': {'path': '', 18:56:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:56:54 INFO - Running post-action listener: _resource_record_post_action 18:56:54 INFO - ##### 18:56:54 INFO - ##### Running create-virtualenv step. 18:56:54 INFO - ##### 18:56:54 INFO - Running pre-action listener: _resource_record_pre_action 18:56:54 INFO - Running main action method: create_virtualenv 18:56:54 INFO - Creating virtualenv /builds/slave/test/build/venv 18:56:54 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 18:56:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:56:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:56:54 INFO - Using real prefix '/usr' 18:56:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:56:55 INFO - Installing distribute.............................................................................................................................................................................................done. 18:56:56 INFO - Installing pip.................done. 18:56:57 INFO - Return code: 0 18:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:57 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:56:57 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 18:56:57 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 18:56:57 INFO - Using env: {'DISPLAY': ':0', 18:56:57 INFO - 'HOME': '/home/cltbld', 18:56:57 INFO - 'LANG': 'en_US.UTF-8', 18:56:57 INFO - 'LANGUAGE': 'en_US:en', 18:56:57 INFO - 'LOGNAME': 'cltbld', 18:56:57 INFO - 'MAIL': '/var/mail/cltbld', 18:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:57 INFO - 'MOZ_NO_REMOTE': '1', 18:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:57 INFO - 'NO_EM_RESTART': '1', 18:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:57 INFO - 'PWD': '/builds/slave/test', 18:56:57 INFO - 'SHELL': '/bin/bash', 18:56:57 INFO - 'SHLVL': '1', 18:56:57 INFO - 'TERM': 'linux', 18:56:57 INFO - 'TMOUT': '86400', 18:56:57 INFO - 'USER': 'cltbld', 18:56:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:57 INFO - '_': '/tools/buildbot/bin/python'} 18:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:57 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 18:56:57 INFO - Cleaning up... 18:56:57 INFO - Return code: 0 18:56:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:57 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:56:57 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 18:56:57 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 18:56:57 INFO - Using env: {'DISPLAY': ':0', 18:56:57 INFO - 'HOME': '/home/cltbld', 18:56:57 INFO - 'LANG': 'en_US.UTF-8', 18:56:57 INFO - 'LANGUAGE': 'en_US:en', 18:56:57 INFO - 'LOGNAME': 'cltbld', 18:56:57 INFO - 'MAIL': '/var/mail/cltbld', 18:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:57 INFO - 'MOZ_NO_REMOTE': '1', 18:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:57 INFO - 'NO_EM_RESTART': '1', 18:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:57 INFO - 'PWD': '/builds/slave/test', 18:56:57 INFO - 'SHELL': '/bin/bash', 18:56:57 INFO - 'SHLVL': '1', 18:56:57 INFO - 'TERM': 'linux', 18:56:57 INFO - 'TMOUT': '86400', 18:56:57 INFO - 'USER': 'cltbld', 18:56:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:57 INFO - '_': '/tools/buildbot/bin/python'} 18:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:57 INFO - Downloading/unpacking psutil>=0.7.1 18:56:57 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 18:56:57 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 18:56:57 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 18:56:57 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 18:56:57 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 18:56:57 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 18:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:59 INFO - Installing collected packages: psutil 18:56:59 INFO - Running setup.py install for psutil 18:56:59 INFO - building 'psutil._psutil_linux' extension 18:56:59 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 18:56:59 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 18:56:59 INFO - building 'psutil._psutil_posix' extension 18:56:59 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 18:56:59 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 18:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:59 INFO - Successfully installed psutil 18:56:59 INFO - Cleaning up... 18:57:00 INFO - Return code: 0 18:57:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:57:00 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')]} 18:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:00 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')]} 18:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:00 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:00 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 18:57:00 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 18:57:00 INFO - Using env: {'DISPLAY': ':0', 18:57:00 INFO - 'HOME': '/home/cltbld', 18:57:00 INFO - 'LANG': 'en_US.UTF-8', 18:57:00 INFO - 'LANGUAGE': 'en_US:en', 18:57:00 INFO - 'LOGNAME': 'cltbld', 18:57:00 INFO - 'MAIL': '/var/mail/cltbld', 18:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:00 INFO - 'MOZ_NO_REMOTE': '1', 18:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:00 INFO - 'NO_EM_RESTART': '1', 18:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:00 INFO - 'PWD': '/builds/slave/test', 18:57:00 INFO - 'SHELL': '/bin/bash', 18:57:00 INFO - 'SHLVL': '1', 18:57:00 INFO - 'TERM': 'linux', 18:57:00 INFO - 'TMOUT': '86400', 18:57:00 INFO - 'USER': 'cltbld', 18:57:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:00 INFO - '_': '/tools/buildbot/bin/python'} 18:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:57:02 INFO - Installing collected packages: mozsystemmonitor 18:57:02 INFO - Running setup.py install for mozsystemmonitor 18:57:02 INFO - Successfully installed mozsystemmonitor 18:57:02 INFO - Cleaning up... 18:57:02 INFO - Return code: 0 18:57:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:57:02 INFO - Using env: {'DISPLAY': ':0', 18:57:02 INFO - 'HOME': '/home/cltbld', 18:57:02 INFO - 'LANG': 'en_US.UTF-8', 18:57:02 INFO - 'LANGUAGE': 'en_US:en', 18:57:02 INFO - 'LOGNAME': 'cltbld', 18:57:02 INFO - 'MAIL': '/var/mail/cltbld', 18:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:02 INFO - 'MOZ_NO_REMOTE': '1', 18:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:02 INFO - 'NO_EM_RESTART': '1', 18:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:02 INFO - 'PWD': '/builds/slave/test', 18:57:02 INFO - 'SHELL': '/bin/bash', 18:57:02 INFO - 'SHLVL': '1', 18:57:02 INFO - 'TERM': 'linux', 18:57:02 INFO - 'TMOUT': '86400', 18:57:02 INFO - 'USER': 'cltbld', 18:57:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:02 INFO - '_': '/tools/buildbot/bin/python'} 18:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:02 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:02 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 18:57:02 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 18:57:02 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 18:57:02 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 18:57:02 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 18:57:02 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 18:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:57:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:05 INFO - Downloading docopt-0.6.1.tar.gz 18:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:05 INFO - Running setup.py install for blobuploader 18:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:57:05 INFO - Running setup.py install for requests 18:57:05 INFO - Running setup.py install for docopt 18:57:05 INFO - Successfully installed blobuploader requests docopt 18:57:05 INFO - Cleaning up... 18:57:05 INFO - Return code: 0 18:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:05 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:05 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 18:57:05 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 18:57:05 INFO - Using env: {'DISPLAY': ':0', 18:57:05 INFO - 'HOME': '/home/cltbld', 18:57:05 INFO - 'LANG': 'en_US.UTF-8', 18:57:05 INFO - 'LANGUAGE': 'en_US:en', 18:57:05 INFO - 'LOGNAME': 'cltbld', 18:57:05 INFO - 'MAIL': '/var/mail/cltbld', 18:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:05 INFO - 'MOZ_NO_REMOTE': '1', 18:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:05 INFO - 'NO_EM_RESTART': '1', 18:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:05 INFO - 'PWD': '/builds/slave/test', 18:57:05 INFO - 'SHELL': '/bin/bash', 18:57:05 INFO - 'SHLVL': '1', 18:57:05 INFO - 'TERM': 'linux', 18:57:05 INFO - 'TMOUT': '86400', 18:57:05 INFO - 'USER': 'cltbld', 18:57:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:05 INFO - '_': '/tools/buildbot/bin/python'} 18:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:05 INFO - Running setup.py (path:/tmp/pip-yt9a5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:06 INFO - Running setup.py (path:/tmp/pip-UzDXpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:06 INFO - Running setup.py (path:/tmp/pip-ZLie9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:06 INFO - Running setup.py (path:/tmp/pip-awLA9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:06 INFO - Running setup.py (path:/tmp/pip-cYyIw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:06 INFO - Running setup.py (path:/tmp/pip-JzBGJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:06 INFO - Running setup.py (path:/tmp/pip-b2Mppw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:06 INFO - Running setup.py (path:/tmp/pip-u0SIZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:06 INFO - Running setup.py (path:/tmp/pip-oanKBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:06 INFO - Running setup.py (path:/tmp/pip-vrzZrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:06 INFO - Running setup.py (path:/tmp/pip-dkkwNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:06 INFO - Running setup.py (path:/tmp/pip-D28OSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:06 INFO - Running setup.py (path:/tmp/pip-qbBaaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:06 INFO - Running setup.py (path:/tmp/pip-ShbVvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:06 INFO - Running setup.py (path:/tmp/pip-9C5Ql0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:07 INFO - Running setup.py (path:/tmp/pip-wC5MSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:07 INFO - Running setup.py (path:/tmp/pip-MYIxaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:07 INFO - Running setup.py install for manifestparser 18:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Running setup.py install for mozcrash 18:57:07 INFO - Running setup.py install for mozdebug 18:57:07 INFO - Running setup.py install for mozdevice 18:57:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Running setup.py install for mozfile 18:57:07 INFO - Running setup.py install for mozhttpd 18:57:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Running setup.py install for mozinfo 18:57:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Running setup.py install for mozInstall 18:57:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:07 INFO - Running setup.py install for mozleak 18:57:08 INFO - Running setup.py install for mozlog 18:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Running setup.py install for moznetwork 18:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Running setup.py install for mozprocess 18:57:08 INFO - Running setup.py install for mozprofile 18:57:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Running setup.py install for mozrunner 18:57:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Running setup.py install for mozscreenshot 18:57:08 INFO - Running setup.py install for moztest 18:57:08 INFO - Running setup.py install for mozversion 18:57:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:08 INFO - Cleaning up... 18:57:08 INFO - Return code: 0 18:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:08 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:08 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 18:57:08 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 18:57:08 INFO - Using env: {'DISPLAY': ':0', 18:57:08 INFO - 'HOME': '/home/cltbld', 18:57:08 INFO - 'LANG': 'en_US.UTF-8', 18:57:08 INFO - 'LANGUAGE': 'en_US:en', 18:57:08 INFO - 'LOGNAME': 'cltbld', 18:57:08 INFO - 'MAIL': '/var/mail/cltbld', 18:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:08 INFO - 'MOZ_NO_REMOTE': '1', 18:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:08 INFO - 'NO_EM_RESTART': '1', 18:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:08 INFO - 'PWD': '/builds/slave/test', 18:57:08 INFO - 'SHELL': '/bin/bash', 18:57:08 INFO - 'SHLVL': '1', 18:57:08 INFO - 'TERM': 'linux', 18:57:08 INFO - 'TMOUT': '86400', 18:57:08 INFO - 'USER': 'cltbld', 18:57:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:08 INFO - '_': '/tools/buildbot/bin/python'} 18:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:09 INFO - Running setup.py (path:/tmp/pip-v3Fr8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:09 INFO - Running setup.py (path:/tmp/pip-_IhYhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:09 INFO - Running setup.py (path:/tmp/pip-BYEEuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:09 INFO - Running setup.py (path:/tmp/pip-CDyfrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:09 INFO - Running setup.py (path:/tmp/pip-gBforZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:09 INFO - Running setup.py (path:/tmp/pip-RRF3xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:09 INFO - Running setup.py (path:/tmp/pip-20LoL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:09 INFO - Running setup.py (path:/tmp/pip-M2brKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:09 INFO - Running setup.py (path:/tmp/pip-13Xkd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:09 INFO - Running setup.py (path:/tmp/pip-1R7WRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:09 INFO - Running setup.py (path:/tmp/pip-SUbMR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:09 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)) 18:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:09 INFO - Running setup.py (path:/tmp/pip-wDE1x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:10 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)) 18:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:10 INFO - Running setup.py (path:/tmp/pip-FIGTnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:10 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)) 18:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:10 INFO - Running setup.py (path:/tmp/pip-1FS70N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:10 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)) 18:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:10 INFO - Running setup.py (path:/tmp/pip-MmUjI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:10 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)) 18:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:10 INFO - Running setup.py (path:/tmp/pip-yZri5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:10 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)) 18:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:10 INFO - Running setup.py (path:/tmp/pip-SCXOxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:10 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)) 18:57:10 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)) 18:57:10 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)) 18:57:10 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)) 18:57:10 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)) 18:57:10 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)) 18:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:10 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 18:57:10 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 18:57:10 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 18:57:10 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 18:57:10 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 18:57:10 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 18:57:12 INFO - Downloading blessings-1.6.tar.gz 18:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:12 INFO - Installing collected packages: blessings 18:57:12 INFO - Running setup.py install for blessings 18:57:12 INFO - Successfully installed blessings 18:57:12 INFO - Cleaning up... 18:57:12 INFO - Return code: 0 18:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:12 INFO - Reading from file tmpfile_stdout 18:57:12 INFO - Current package versions: 18:57:12 INFO - argparse == 1.2.1 18:57:12 INFO - blessings == 1.6 18:57:12 INFO - blobuploader == 1.2.4 18:57:12 INFO - docopt == 0.6.1 18:57:12 INFO - manifestparser == 1.1 18:57:12 INFO - mozInstall == 1.12 18:57:12 INFO - mozcrash == 0.17 18:57:12 INFO - mozdebug == 0.1 18:57:12 INFO - mozdevice == 0.48 18:57:12 INFO - mozfile == 1.2 18:57:12 INFO - mozhttpd == 0.7 18:57:12 INFO - mozinfo == 0.9 18:57:12 INFO - mozleak == 0.1 18:57:12 INFO - mozlog == 3.1 18:57:12 INFO - moznetwork == 0.27 18:57:12 INFO - mozprocess == 0.22 18:57:12 INFO - mozprofile == 0.28 18:57:12 INFO - mozrunner == 6.11 18:57:12 INFO - mozscreenshot == 0.1 18:57:12 INFO - mozsystemmonitor == 0.0 18:57:12 INFO - moztest == 0.7 18:57:12 INFO - mozversion == 1.4 18:57:12 INFO - psutil == 3.1.1 18:57:12 INFO - requests == 1.2.3 18:57:12 INFO - wsgiref == 0.1.2 18:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:12 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')]} 18:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:12 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')]} 18:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:12 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:12 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 18:57:12 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 18:57:12 INFO - Using env: {'DISPLAY': ':0', 18:57:12 INFO - 'HOME': '/home/cltbld', 18:57:12 INFO - 'LANG': 'en_US.UTF-8', 18:57:12 INFO - 'LANGUAGE': 'en_US:en', 18:57:12 INFO - 'LOGNAME': 'cltbld', 18:57:12 INFO - 'MAIL': '/var/mail/cltbld', 18:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:12 INFO - 'MOZ_NO_REMOTE': '1', 18:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:12 INFO - 'NO_EM_RESTART': '1', 18:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:12 INFO - 'PWD': '/builds/slave/test', 18:57:12 INFO - 'SHELL': '/bin/bash', 18:57:12 INFO - 'SHLVL': '1', 18:57:12 INFO - 'TERM': 'linux', 18:57:12 INFO - 'TMOUT': '86400', 18:57:12 INFO - 'USER': 'cltbld', 18:57:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:12 INFO - '_': '/tools/buildbot/bin/python'} 18:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 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)) 18:57:12 INFO - Cleaning up... 18:57:12 INFO - Return code: 0 18:57:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:57:12 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')]} 18:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:12 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')]} 18:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:12 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 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:12 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 18:57:12 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 18:57:12 INFO - Using env: {'DISPLAY': ':0', 18:57:12 INFO - 'HOME': '/home/cltbld', 18:57:12 INFO - 'LANG': 'en_US.UTF-8', 18:57:12 INFO - 'LANGUAGE': 'en_US:en', 18:57:12 INFO - 'LOGNAME': 'cltbld', 18:57:12 INFO - 'MAIL': '/var/mail/cltbld', 18:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:12 INFO - 'MOZ_NO_REMOTE': '1', 18:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:12 INFO - 'NO_EM_RESTART': '1', 18:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:12 INFO - 'PWD': '/builds/slave/test', 18:57:12 INFO - 'SHELL': '/bin/bash', 18:57:12 INFO - 'SHLVL': '1', 18:57:12 INFO - 'TERM': 'linux', 18:57:12 INFO - 'TMOUT': '86400', 18:57:12 INFO - 'USER': 'cltbld', 18:57:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:12 INFO - '_': '/tools/buildbot/bin/python'} 18:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:13 INFO - Downloading/unpacking jsonschema 18:57:13 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 18:57:13 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 18:57:13 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 18:57:13 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 18:57:13 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 18:57:13 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 18:57:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:15 INFO - Downloading/unpacking functools32 (from jsonschema) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:15 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:15 INFO - warning: no files found matching '*.txt' 18:57:15 INFO - no previously-included directories found matching 'build' 18:57:15 INFO - no previously-included directories found matching 'dist' 18:57:15 INFO - no previously-included directories found matching '.git*' 18:57:15 INFO - Installing collected packages: jsonschema, functools32 18:57:15 INFO - Running setup.py install for functools32 18:57:15 INFO - warning: no files found matching '*.txt' 18:57:15 INFO - no previously-included directories found matching 'build' 18:57:15 INFO - no previously-included directories found matching 'dist' 18:57:15 INFO - no previously-included directories found matching '.git*' 18:57:15 INFO - Successfully installed jsonschema functools32 18:57:15 INFO - Cleaning up... 18:57:15 INFO - Return code: 0 18:57:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9e795f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, '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': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', '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 18:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:57:15 INFO - Using env: {'DISPLAY': ':0', 18:57:15 INFO - 'HOME': '/home/cltbld', 18:57:15 INFO - 'LANG': 'en_US.UTF-8', 18:57:15 INFO - 'LANGUAGE': 'en_US:en', 18:57:15 INFO - 'LOGNAME': 'cltbld', 18:57:15 INFO - 'MAIL': '/var/mail/cltbld', 18:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:15 INFO - 'MOZ_NO_REMOTE': '1', 18:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:15 INFO - 'NO_EM_RESTART': '1', 18:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:15 INFO - 'PWD': '/builds/slave/test', 18:57:15 INFO - 'SHELL': '/bin/bash', 18:57:15 INFO - 'SHLVL': '1', 18:57:15 INFO - 'TERM': 'linux', 18:57:15 INFO - 'TMOUT': '86400', 18:57:15 INFO - 'USER': 'cltbld', 18:57:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:15 INFO - '_': '/tools/buildbot/bin/python'} 18:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:15 INFO - Downloading/unpacking flake8 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:57:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:57:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:18 INFO - no previously-included directories found matching 'docs/_build' 18:57:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:57:18 INFO - Running setup.py install for pep8 18:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:18 INFO - no previously-included directories found matching 'docs/_build' 18:57:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:57:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:57:18 INFO - Cleaning up... 18:57:19 INFO - Return code: 0 18:57:19 INFO - Running post-action listener: _resource_record_post_action 18:57:19 INFO - Running post-action listener: _start_resource_monitoring 18:57:19 INFO - Starting resource monitoring. 18:57:19 INFO - ##### 18:57:19 INFO - ##### Running install step. 18:57:19 INFO - ##### 18:57:19 INFO - Running pre-action listener: _resource_record_pre_action 18:57:19 INFO - Running main action method: install 18:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:19 INFO - Reading from file tmpfile_stdout 18:57:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:19 INFO - Reading from file tmpfile_stdout 18:57:19 INFO - Output received: 18:57:19 INFO - Usage: mozinstall [options] installer 18:57:19 INFO - Options: 18:57:19 INFO - -h, --help show this help message and exit 18:57:19 INFO - -d DEST, --destination=DEST 18:57:19 INFO - Directory to install application into. [default: 18:57:19 INFO - "/builds/slave/test"] 18:57:19 INFO - --app=APP Application being installed. [default: firefox] 18:57:19 INFO - mkdir: /builds/slave/test/build/application 18:57:19 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'] 18:57:19 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 18:57:35 INFO - Reading from file tmpfile_stdout 18:57:35 INFO - Output received: 18:57:35 INFO - /builds/slave/test/build/application/firefox/firefox 18:57:35 INFO - Running post-action listener: _resource_record_post_action 18:57:35 INFO - ##### 18:57:35 INFO - ##### Running run-tests step. 18:57:35 INFO - ##### 18:57:35 INFO - Running pre-action listener: _resource_record_pre_action 18:57:35 INFO - Running main action method: run_tests 18:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:57:35 INFO - Python 2.7.3 18:57:35 INFO - Return code: 0 18:57:35 INFO - grabbing minidump binary from tooltool 18:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:35 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 0x1ca6410>, '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 0x1ca7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:57:35 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 18:57:35 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 18:57:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:57:35 INFO - Return code: 0 18:57:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:57:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:57:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:57:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:57:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:57:36 INFO - Return code: 0 18:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:57:36 INFO - Using env: {'DISPLAY': ':0', 18:57:36 INFO - 'HOME': '/home/cltbld', 18:57:36 INFO - 'LANG': 'en_US.UTF-8', 18:57:36 INFO - 'LANGUAGE': 'en_US:en', 18:57:36 INFO - 'LOGNAME': 'cltbld', 18:57:36 INFO - 'MAIL': '/var/mail/cltbld', 18:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:36 INFO - 'MOZ_NO_REMOTE': '1', 18:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:36 INFO - 'NO_EM_RESTART': '1', 18:57:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:36 INFO - 'PWD': '/builds/slave/test', 18:57:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:57:36 INFO - 'SHELL': '/bin/bash', 18:57:36 INFO - 'SHLVL': '1', 18:57:36 INFO - 'TERM': 'linux', 18:57:36 INFO - 'TMOUT': '86400', 18:57:36 INFO - 'USER': 'cltbld', 18:57:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161', 18:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:36 INFO - '_': '/tools/buildbot/bin/python'} 18:57:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:57:36 INFO - mozversion application_buildid: 20160425175058 18:57:36 INFO - mozversion application_changeset: f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81 18:57:36 INFO - mozversion application_display_name: Nightly 18:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:57:36 INFO - mozversion application_name: Firefox 18:57:36 INFO - mozversion application_remotingname: firefox 18:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:57:36 INFO - mozversion application_vendor: Mozilla 18:57:36 INFO - mozversion application_version: 49.0a1 18:57:36 INFO - mozversion platform_buildid: 20160425175058 18:57:36 INFO - mozversion platform_changeset: f1e0c231d7e49ea0f2e25eb3b64ed811d3614f81 18:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:57:36 INFO - mozversion platform_version: 49.0a1 18:57:36 INFO - using testdate: 1461635856 18:57:36 INFO - actual date: 1461635856 18:57:36 INFO - starting webserver on 'localhost:39081' 18:57:36 INFO - SUITE-START | Running 2 tests 18:57:36 INFO - TEST-START | dromaeo_css 18:57:36 INFO - operating with platform_type : linux_ 18:57:36 INFO - Initialising browser for dromaeo_css test... 18:57:36 INFO - TEST-INFO | started process 12321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9aamdx/profile http://localhost:39081/getInfo.html) 18:57:40 INFO - PROCESS | 12321 | __metrics Screen width/height:1600/1200 18:57:40 INFO - PROCESS | 12321 | colorDepth:24 18:57:40 INFO - PROCESS | 12321 | Browser inner width/height: 1024/697 18:57:40 INFO - PROCESS | 12321 | __metrics 18:57:41 ERROR - PROCESS | 12321 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:57:41 INFO - TEST-INFO | 12321: exit 0 18:57:41 INFO - Browser initialized. 18:57:41 INFO - Running cycle 1/1 for dromaeo_css test... 18:57:41 INFO - TEST-INFO | started process 12404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9aamdx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:53 INFO - PROCESS | 12404 | RSS: Main: 155815936 18:57:53 INFO - PROCESS | 12404 | 18:58:45 INFO - PROCESS | 12404 | 1461635925062 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] 19:00:56 INFO - PROCESS | 12404 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39081/tests/dromaeo/cssquery-ext.html) 19:00:57 INFO - PROCESS | 12404 | RSS: Main: 240123904 19:00:57 INFO - PROCESS | 12404 | 19:03:59 INFO - PROCESS | 12404 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-ext.html (next: http://localhost:39081/tests/dromaeo/cssquery-jquery.html) 19:04:00 INFO - PROCESS | 12404 | RSS: Main: 238968832 19:04:00 INFO - PROCESS | 12404 | 19:07:02 INFO - PROCESS | 12404 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39081/tests/dromaeo/cssquery-mootools.html) 19:07:03 INFO - PROCESS | 12404 | RSS: Main: 242155520 19:07:03 INFO - PROCESS | 12404 | 19:10:05 INFO - PROCESS | 12404 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39081/tests/dromaeo/cssquery-prototype.html) 19:10:05 INFO - PROCESS | 12404 | RSS: Main: 229855232 19:10:05 INFO - PROCESS | 12404 | 19:13:08 INFO - PROCESS | 12404 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39081/tests/dromaeo/cssquery-yui.html) 19:13:09 INFO - PROCESS | 12404 | RSS: Main: 204234752 19:13:09 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | Cycle 1(1): loaded http://localhost:39081/tests/dromaeo/cssquery-yui.html (next: http://localhost:39081/tests/dromaeo/cssquery-dojo.html) 19:16:12 INFO - PROCESS | 12404 | RSS: Main: 266420224 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | __start_tp_report 19:16:12 INFO - PROCESS | 12404 | _x_x_mozilla_page_load 19:16:12 INFO - PROCESS | 12404 | _x_x_mozilla_page_load_details 19:16:12 INFO - PROCESS | 12404 | |i|pagename|runs| 19:16:12 INFO - PROCESS | 12404 | |0;dojo.html;2548.10816214325;2615.3461634591354;2620.842749435034;2643.1806140096573;2658.574628059511;4466.6426685865135;4543.363929049928;4568;4571.611413029892;4576.656750743695;4641.071785642868;4642.303654451834;4729.574338309551;4735.8816029599275;4746.430428348603;4230.830766769325;4268.594483524068;4308.310670292738;4361.542038086003;4382.12357528494;4340.392345071693;4381.298992161255;4392.143532011259;4393.05549306899;4408.118376324732;4096.3855421686685;4182;4221.197972385237;4282.8715138545895;4307.978460107695;4247.150569886036;4286.39990401344;4291.849785257501;4312.3531470279395;4337.587929146726;4211.768352740598;4251.91496170078;4262.1049579588325;4267.061246525759;4292.914141717149;4374.343848422762;4479.10417916418;4538.841140560065;4572.039871626962;4584.220682483986;4906.9263961040615;4918.04098200851;4933.235348520985;4940.925886111711;4971.7762700678195;4926.5812405945535;4957.702537847741;4959.082569724576;4974.701517908937;5009.674371165863;4499.932501012455;4655.068986202739;4660.6970546914345;4746.95253047472;4756.334113224151;5088.185890257541;5104.979004199175;5108;5123.795048198105;5148.819791307286;4872.074305881871;4892.681975671641;4897.1185186666025;4943.703377797344;4946.332245146931;4751.548602882721;4897.41231052276;4958.206686930074;4964.379452568429;5023;4899.779509921991;4904.950950490521;4915.5330243626795;4919.065377578248;4948.777305021283;4884.065859980141;4900.436449808318;4906.2640603909695;4909.852704418801;4954.232094025432;4149.3775933609595;4226.556211597799;4227.217964676544;4231.386448964883;4295.720778149473;3675.2649470106085;3694.242680250542;3708.35103856824;3709.0727318170457;3710.8330125143893;4161.354989976498;4217.7891105444605;4249.5113061997645;4349.108432771274;4352.542982986804;4943.209086546135;4944.159492886218;4945.505449455026;4946.554810067111;4991.875203119878;4234.1108367242605;4236.576342365739;4242.915141697149;4277.101808620162;4279.7218180818145;4371.300591905344;4430;4468.352088947085;4533.342665313511;4547.795349209294;4664.626829853603;4669.39297891272;4684.976575117171;4689.366935463737;4734.692245004064;4966.304717339648;4976.552110310089;4978.950210497848;4981.875453113701;5026.296318515338;4425.358323043205;4664.953350466452;4734.19518681818;4768.1417344878255;4790.688605240648;4850.320955066364;4873.293372461044;4875.000624871822;4875.731834748981;4918.5573298403315;4828.951710482991;4870.512948705101;4883.389576302962;4888.169011268022;4920.188168952082;4729.479757226633;4824.204006338915;4830.806767729392;4853.6359773017875;4872.512748725099;4772.427308722976;4811.182099043241;4811.350467686818;4815.783289752039;4859.684120532154;4593.632509399307;4632.675712700078;4749.762511874462;4750.7862146202815;4800.711957282574;4865.294532292868;4873.4882837301575;4883.194272945067;4903.828366007173;4927.260910863256;4768.165571025126;4773;4775.570198682135;4778.713277203379;4816.8073277069925 19:16:12 INFO - PROCESS | 12404 | |1;ext.html;542.1948406616177;555.2088274209251;577.3014652270753;596.829903477509;603.5624172474957;28810.711892881063;34878.476822847675;35116;35332.64667353326;35502.46746298801;37618.0595485113;38428.23143537128;38473.807630961805;38520.807395962984;38565.80717096411;7216.855662886739;7668.731594394198;7876.212378762107;7891.131975482721;9592.568334424932;9541.427514349161;9689.515524223796;9717.46553939533;9718.951405242999;9726.124648781608;9654.03459654036;9812.950935245313;9819.950900245525;9820.459874706889;9826.263030272758;9673.274504412162;9746.46394448305;9766.951165244129;9781.853272200922;9789.804203915883;9698.9515052425;9839.80320393588;10035.648752293708;10035.949820250851;10051.69844904654;38396.61603383986;38862.61137388618;38864.22271554553;38911.41632875509;38975;3027.439923614116;3028.4548781219373;3060.8469576521084;3117.4544454720335;3162.383335249627;29601.407971840443;29960;29990.7610693317;30057.398852023056;30779.692203077906;3351.9664803351898;3351.983240083784;3412.2151905061974;3456.6370531094126;3491.8428670709877;227711;228078;228521;228767;229113;55332.17001744977;55605.165922511194;55687.72156139275;55706.72146639322;55806.72096639491;57214.71392643094;57787.71106144526;57788.4221157783;57821.42178578245;57846.13230801541;14590.270486475634;15122.168280744445;15139.486051394771;15151.621209469631;15167.696646067237;9781;10221.437820919771;10431.321964072311;10449.425281609432;10475.1096156826;17114.20300868416;17206.483805485856;17207.311707531557;17223.91388043077;17244.741328880078;5814.244148260699;5936.009261292165;5964.373740757158;5976.850578735566;6145.508359331243;856.280724191682;865.9653613855501;935.9157675809209;1013.9290249682451;1031.7626945802508;25420.618690719653;27054;27372.178834634993;27819.16542503728;29328.120156394914;1016.3800081950004;1017.3590637898225;1019.5564929255797;1038.2680210451613;1097.7310558913118;13925.930370348286;14555.19946402958;14570.271486425636;14801.18593477369;14858.554243372717;325126;325530;330008;330468;330529;48646.513534864906;48748.75625621849;48835;48879.75560122177;48883.75558122258;1105.2429086076063;1223.1499108119772;1232.3160645841645;1272.465564462928;1293.7089154940252;25692.357691057874;28220.71779282263;28469.288267793472;28473;28897;39794.60205398025;39860.40209396919;40192.79903600463;40245;40248.597514024485;230339;231367;231607;231811;232092;21362.465938351666;23904.16335428252;24105.758942411052;24161.51676966416;24252.87873560621;35691.64308356987;36771.44842827413;40346.394804077376;41060;41148.38277425901;34123.65876341205;34726.82636586801;35176.12059698528;35636;35974.64025359713;31987;35022.29955400929;35077.298454030264;35099.29801404009;35817;34512.48231276483;34668.47997279993;34950.30099397947;34965.47551786776;34998.65001349954;30823.2294192647;31506.684933151293;31571.684283156876;31572.684273156974;31642.525362120046;24516.6322505159;24556.754432455447;24976.50046999086;25102.49795004053;25151.622725658763 19:16:12 INFO - PROCESS | 12404 | |2;jquery.html;377.5733421234006;382.19738549047;389.9044734040161;391.0809597446002;393.84246301479425;15711.292991815368;16425.75361369579;16549.924254923422;16555.83444165558;16881.155942202902;11784;15991.360345586163;16646.66706665869;16652;16704.58238544037;4677.999999999992;4822.180229361017;4903.289023091667;4914.729689867056;4915.754212289389;3582.8566857325804;5334.386545547273;5642.351129620085;5649.830505084854;5657.688827114507;5566.832995010156;5624.971875140619;5626.521745651625;5652.434756524356;5655.095184770437;5412.079946409101;5518.117101263819;5548.056830338852;5556.305461817273;5557.944420555803;3507.736919731005;5225.634205605609;5493.121100623921;5521.199426083195;5521.668699878021;11841.526338946433;12181.878181218162;12298.446569904376;12301.630951071482;12525.37373131349;1896.0614495824518;2253.042456955787;2266.784655457729;2407.831451798375;2414.770596793302;9066.093390660948;9324.440533568008;9449.527523623792;9554.23566114716;9723.076307750753;1629.9429519966745;1708.5386945524763;1725.620363520036;1730.2041061111904;1858.8327050565515;62147.6892615534;71019.64490177516;71051.64474177647;71498.99999999948;71530.64234678846;9909.900900991042;10064.068606382965;10120.74698132538;10209.9489502552;10266.897331026743;14126;14229.573112806633;14248.216348100954;14251.928740356232;14252.643683907985;6868.278830722702;6964.547304425196;7043;7061.576305421691;7393.112826460859;6785;6926.965365173141;6982.1272340957385;7091.042709234291;7107.964460177769;4363.738175709467;4439.378487011821;4457.955420445819;4484.977575112103;4551.431071116111;1733.4539620019652;1775;1852.740616313717;1876.981230187708;1914.9904250478658;812.6505602590943;837.2422957223722;863.2532859076854;885.2829208341265;986.5609803637456;15638.452654157278;16507.83492165087;16785.160741962853;16964.83035169657;17632.294708211528;878.1350369885657;896.5069211933411;934.4768028114266;938.638624129715;959.9760005999906;9252.213561847184;9475.147236748726;9801.656942007137;9847.064528869745;9976.650817221362;354191;384298;384915;387020;388074;77501;81069.18930810735;81127.59436202899;81172;81333.59333203296;962.5620342744035;974.1846064872524;979.5543027922279;990.2276224544867;996.2030375699411;15268.770968435705;15287.388504459697;15352.155631440379;15449.84550154484;15778;35571.288574228885;35914.820425897706;35920.844749315125;36064.45903311505;36150.107991361154;49256.261156083405;51515.74242128765;51747;52435.213471798714;52526.737366312926;7823.2567906048835;7994.920050799417;8029.397795165269;8091.83816323682;8232.259096681328;11038.448077595927;11292.378919159524;11926.403679815801;12268.938655306667;12282;10142.442165680959;10204.744881378025;10632.734181645521;10785.62250321235;10925.890741092806;5034.622403319839;5553.4724201200825;8466.70366537193;8857.424267422597;10495.947520262349;10393.896061039595;10395.740106497398;10815.188860835311;10835.891641083803;10912.61805836792;7932.206779322021;8027.1972802719265;8065.83868322642;8110.600916356237;8130.959345203236;8111.391645626483;9373.25013998892;10464.529096190538;10818.945905270422;10840.970107839743 19:16:12 INFO - PROCESS | 12404 | |3;mootools.html;1207.9033677305817;1449.4129877399653;1485.0347274271726;1590.984090159098;1771.627958128793;6169.506439484841;7208.819779505508;7390.408767298617;7413.369863561604;7419.629018549072;7012.754553590626;7148.463865210104;7155.284471552855;7163.032990546275;7165.641717914096;1827.6892928202171;1880.9717854232197;1884.9057547122657;2173.663082222254;2212.358416059341;2215.6122678531274;2292.9541409171807;2296.196331284054;2299.218265789631;2299.7470278269375;2157.5037741319506;2182.978170218293;2184.497565559914;2184.737831460227;2200.680901269323;1795.5331613780381;2143.710599069121;2221.3224966385246;2232.2968264996475;2232.9330120096506;2199.43914301852;2226.1874415838265;2228.810551103158;2230.342049095521;2232.1294695068937;7068.3285087916565;7144.714211431537;7153.320434558708;7209.134903811524;7211.855762884766;4189.05746207104;4301.247281725717;4305.763183024932;4328.199283132599;4355.629771469429;2639.129087401172;2748.491529067109;2764.115483045426;2770.1966429735353;2790.860456977143;846.0777752250016;875.4484674654926;883.0595415882065;884.8363052835182;890.7505898348472;10026;10241.334313269688;10243.53904074311;10255.333403328834;10269.486525673761;4136.883041578757;4169.145325208325;4255.553166917491;4291.742495450283;4304.74171549708;8815.206631403205;8886.066962968924;8900.732978010541;8901.821963560693;8908.777280568038;4637.582617564368;4642.442906851199;4644.651651126179;4646.279826626878;4649.232876575327;3512.350215210194;3973.106051138471;4137.937930931039;4171.249175148502;4217.957820421757;3515.736319776027;3523.5067090607336;3575.9284814304087;3584.946225806615;3632.8728494503093;1173.137743758337;1175.488662431845;1175.7295821960997;1176.1355403778216;1184.6209213051914;747.2340850628041;756.2588663110073;841.4068082002174;845.8308338332358;861.5347712235448;4739.123262196505;4965.503449655005;4975.90048199034;5078.695278283241;5122.154844450699;411.22278892892456;423.45585922089964;429.58665988896803;429.60047156145083;439.41338313351395;3418.743594230393;3434.364642541138;3501.1947252132154;3501.9474707879403;3549.165946002687;8842.602082906285;9153.81692366149;9222.123898229658;9360;9369.672061477815;9230;9264.861027084598;9291.117343852324;9293.163615274658;9300.674476393293;6669.399754022162;6695.866082678319;6929.930700693029;7011.193712723;7011.5091943564485;5155.819546316011;5245.396779370421;5276.472352764693;5314.362276526842;5389.892202156013;8560.143985601639;8566.871496927675;8658.48049117055;8756.956215218883;8763.868541971748;8562.700305489278;8808.91191088081;8821.117888211127;8875.245604123464;8925.152110549487;5460.071787796163;6299.307076221704;6504.512161587805;6593.571417857824;6608.834779130368;7317.121945366377;7352;7435;7441.516301440389;7448.329650331496;6411.326810684811;6556.213254409501;6646.169228846395;6661.500387470862;6795.354441328066;6599.175103112111;6661.067450557023;6663.533552651462;6713.597184168965;6725.19297684281;6205.100260462298;6243.313235544178;6261.467775239155;6270.278917924497;6273.52948528853;4376.212281789309;4407.823687052611;4480.731156130642;4491.550844915482;4492.842750503717;4522.5929666330185;4526.796294166837;4555.589996900162;4585.082983403399;4673.112108699336 19:16:12 INFO - PROCESS | 12404 | |4;prototype.html;297.6353966391171;300.5206695320963;303.5931851319232;304.932914758753;306.19318096814885;4667.432911898455;4735.857924262269;4740.9288860667075;4744.620430365571;4754.120487709776;4658.346287068093;4671.252599584067;4679.204535229011;4686.625069994401;4706.4822869484415;3511.0682580045627;3657.5128912339596;3658.1769101952113;3659.323025240326;3671.6695497405226;3580.6598373154507;3663.798491083003;3717.8512859485586;3733.7573057751297;3760.1539653578;3655.597884232732;3700.0009997300713;3700.907477313062;3702.1670124222105;3729.403295472725;3629.0745859805843;3683.355412802749;3720.3675375186417;3723.422869455239;3723.478712980185;3282.688144626257;3301.1417031571723;3303.7687361884678;3309.3050459403553;3313.2379552703014;4539.0921815636675;4554.521775213621;4557.361969324297;4567.497575266718;4572.51988541205;4238.682098842568;4241.533431322552;4245.299525578276;4249.681273904439;4254.08537164508;4801.135795556798;4921.237208232729;4941.45643979162;4960.677555958851;4968.6025117990475;3574.767640103411;3585.551806024247;3593.1735700788963;3598.7300952428673;3613.5844377896615;5147.819826306099;5148.502976056609;5148.948510514884;5153.819616313411;5185.55922746567;3562.3943929532043;3646.21606354635;3654.3239500691925;3657.9268414632093;3682.429223470366;3686.4838922550866;3686.668199862025;3696.4085746281003;3705.2404257127223;3706.09200745819;4141.565135660772;4148.91702165961;4156.376543518496;4183.372494125905;4191.287481128215;4874.512548745168;4883.875514151285;4908.141075311878;4909.68087074339;4926.448168826808;1303.3548393545257;1342.5435351980373;1366.9179849209079;1374.8075269462283;1377.4008306386554;916.5325683901258;927.3832901120815;932.5616960028775;936.7611259128879;938.9154976052051;4208.263553878059;4243.342281946303;4390.626796722315;4391.538888416734;4411.448568928884;5060.2156665716875;5063.8480845574695;5080.466551012164;5091.872703182376;5095.847124586268;4358.3680366347335;4366.039471316305;4373;4396.582324679151;4406.911861762746;2790.5674620433865;2857.7570906472765;2895.8552072396296;2896.102208315429;2915.7230063143966;5110.897782044412;5127.564157046618;5137.790749977471;5145.408278048072;5145.4597267287145;5335.359756829128;5572.498475137176;5575.832725018256;5575.944240557624;5579.079451890392;5076.771545280471;5077.923831142536;5087.186050232019;5092.541671249605;5095.464976177596;5373.596980226421;5384.326959130109;5391.29913111293;5395.70323632204;5427.728613569385;4814.6870453420415;5071.467495912876;5319.202119682079;5350;5363.115086010921;4838.903221935471;4847.660663753503;4860.756962151949;4880.41435027799;4906.8773280668265;3578.177019285527;3623.6376362363553;3624.710023198085;3631.0755299691205;3643.1620727232353;5000.324956130876;5115.2071428928575;5179.30079439286;5198.740062996911;5201.540975251415;4976.477469865612;4979.726115063706;4999.825006124768;5021.472745361684;5025.296458495741;5009.799608015638;5010.774515146754;5013.448520662651;5016.473270306711;5024.522670346311;4829.903401932012;4936.827211047596;4950.480199578992;4958;4958.727240021569;4766.856994290177;4890.70396344976;5011.824586139468;5055.823046193365;5063.1645778446145;4883.731394773322;4914.950850491449;4924.630652701134;4926.113299606105;4933.21068629032 19:16:12 INFO - PROCESS | 12404 | |5;yui.html;716.2050124361957;732.2018999290774;763.4465012865674;787.2993036197785;788.1330536409946;12176.269423834576;12636.557720479785;12677.239365638045;12882;12905.80641290379;11978.880211197886;12041.879581204184;12051.578194763186;12113.212641178317;12142.210756300834;625.9937400626004;792.128658475675;800.0599295827394;810.7689308547066;810.9026916769996;804.951702897825;806.2139414071263;806.9152738962383;808.1837344282288;809.0614886731393;862.5169904853302;865.4634126841368;866.1295398124876;866.2766589897411;866.6749968761715;679.4428568573771;836.3267569606464;859.4413631139747;862.2799962031711;865.2299453486402;630.9652969086699;632.1844820182006;632.9398707122816;633.2274624957545;633.7560039384824;12443.25340479565;12475.50097996079;12525.060620453502;12551.435185416678;12570.622881313575;12097.185422186654;12369.443375048144;12882.935585322108;12995.740085198338;13086.541971031063;11114.22200445969;11116.777664446747;11199.60801371948;11277.266977646426;11308.37803920784;4198.412222288882;4231.682623803227;4305.698601097924;4339.414179085815;4379.189849877783;42446;42993;43032.35451468199;43049.78475107636;43175.784121079196;9959.302848800658;10353.689389318333;10487.213458990605;10593.682189534326;10837.349759014327;17260.136993150543;17602.29590816353;17612;18119.818801812078;18214.90892545529;6892.724291028403;6913.343232392915;7028.297170283033;7089.113860767404;7099.538529995534;3757.323681737259;3798.9620103798607;3806.5051543299746;3903.4730311408166;3919.118198405336;2841.0766500887294;2923.6053132826796;2926.268432891777;2926.4000879819587;2927.107232294171;524.6490287509678;525.7528961388141;535.253321616343;537.1834811087126;537.2612657595806;534.767376191358;571.3172758553488;605.379486026826;648.5751832549688;664.5647101148755;7444.553326800409;7832.530048197126;7836.608169591497;7882;7923.217276112944;582.135528739821;619.7923695561947;626.2547568393597;648.5427773419727;654.0385633119307;3639.1266096136737;3698.6671199592165;3711.9443208351895;3734.0291524203903;3845.692344612424;46047.76976115098;48212;49044.75477622589;49128.26307605389;49140;43224.351634725506;44151.558484415385;44439.11121777546;45712.08575828465;45825.54174458213;40339.798301008894;41397.1720565587;41414.58585414107;41494.170116597496;41599;7319.670614822239;7447.478676492594;7499.925000749922;7545.698172073276;7696.807579810549;28342;28993;29027.274318142216;29136.56295155532;29490.410191796473;33906.83046584751;34501.48247776235;36670.633293666724;36684;36828.81585592055;9889.950550247202;10069.395836249849;10554.2084343673;10584.206184536037;10918.672439826818;11093.5562577496;11185.32888026721;11635.127365447455;11709.648710538697;12468.376581171087;10680.092192163442;10905.509252083833;11012.724681883017;11067.225294229327;11126.721831954266;10906.50920708554;11125.221234513507;11373.715657108638;11673.883261167279;11854.170208085696;10921.290116142425;11042.889571104186;11043.282186657842;11247.381394023407;11733.237339573241;8913.821723565623;8948.910510894808;9032.367734258802;9299.116583924517;9312.022237664947;8890.377673562789;8922.107789221025;8958.238549723346;8971.147740964598;9137 19:16:12 INFO - PROCESS | 12404 | __end_tp_report 19:16:12 INFO - PROCESS | 12404 | __start_cc_report 19:16:12 INFO - PROCESS | 12404 | _x_x_mozilla_cycle_collect,854 19:16:12 INFO - PROCESS | 12404 | __end_cc_report 19:16:12 INFO - PROCESS | 12404 | __startTimestamp1461636972521__endTimestamp 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | ------- Summary: start ------- 19:16:12 INFO - PROCESS | 12404 | Number of tests: 6 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | [#0] dojo.html Cycles:165 Average:4580.73 Median:4735.88 stddev:471.42 (10.0%) stddev-sans-first:445.08 19:16:12 INFO - PROCESS | 12404 | Values: 2548.1 2615.3 2620.8 2643.2 2658.6 4466.6 4543.4 4568.0 4571.6 4576.7 4641.1 4642.3 4729.6 4735.9 4746.4 4230.8 4268.6 4308.3 4361.5 4382.1 4340.4 4381.3 4392.1 4393.1 4408.1 4096.4 4182.0 4221.2 4282.9 4308.0 4247.2 4286.4 4291.8 4312.4 4337.6 4211.8 4251.9 4262.1 4267.1 4292.9 4374.3 4479.1 4538.8 4572.0 4584.2 4906.9 4918.0 4933.2 4940.9 4971.8 4926.6 4957.7 4959.1 4974.7 5009.7 4499.9 4655.1 4660.7 4747.0 4756.3 5088.2 5105.0 5108.0 5123.8 5148.8 4872.1 4892.7 4897.1 4943.7 4946.3 4751.5 4897.4 4958.2 4964.4 5023.0 4899.8 4905.0 4915.5 4919.1 4948.8 4884.1 4900.4 4906.3 4909.9 4954.2 4149.4 4226.6 4227.2 4231.4 4295.7 3675.3 3694.2 3708.4 3709.1 3710.8 4161.4 4217.8 4249.5 4349.1 4352.5 4943.2 4944.2 4945.5 4946.6 4991.9 4234.1 4236.6 4242.9 4277.1 4279.7 4371.3 4430.0 4468.4 4533.3 4547.8 4664.6 4669.4 4685.0 4689.4 4734.7 4966.3 4976.6 4979.0 4981.9 5026.3 4425.4 4665.0 4734.2 4768.1 4790.7 4850.3 4873.3 4875.0 4875.7 4918.6 4829.0 4870.5 4883.4 4888.2 4920.2 4729.5 4824.2 4830.8 4853.6 4872.5 4772.4 4811.2 4811.4 4815.8 4859.7 4593.6 4632.7 4749.8 4750.8 4800.7 4865.3 4873.5 4883.2 4903.8 4927.3 4768.2 4773.0 4775.6 4778.7 4816.8 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | [#1] ext.html Cycles:180 Average:42520.98 Median:18984.56 stddev:69742.78 (367.4%) stddev-sans-first:69867.20 19:16:12 INFO - PROCESS | 12404 | Values: 542.2 555.2 577.3 596.8 603.6 28810.7 34878.5 35116.0 35332.6 35502.5 37618.1 38428.2 38473.8 38520.8 38565.8 7216.9 7668.7 7876.2 7891.1 9592.6 9541.4 9689.5 9717.5 9719.0 9726.1 9654.0 9813.0 9820.0 9820.5 9826.3 9673.3 9746.5 9767.0 9781.9 9789.8 9699.0 9839.8 10035.6 10035.9 10051.7 38396.6 38862.6 38864.2 38911.4 38975.0 3027.4 3028.5 3060.8 3117.5 3162.4 29601.4 29960.0 29990.8 30057.4 30779.7 3352.0 3352.0 3412.2 3456.6 3491.8 227711.0 228078.0 228521.0 228767.0 229113.0 55332.2 55605.2 55687.7 55706.7 55806.7 57214.7 57787.7 57788.4 57821.4 57846.1 14590.3 15122.2 15139.5 15151.6 15167.7 9781.0 10221.4 10431.3 10449.4 10475.1 17114.2 17206.5 17207.3 17223.9 17244.7 5814.2 5936.0 5964.4 5976.9 6145.5 856.3 866.0 935.9 1013.9 1031.8 25420.6 27054.0 27372.2 27819.2 29328.1 1016.4 1017.4 1019.6 1038.3 1097.7 13925.9 14555.2 14570.3 14801.2 14858.6 325126.0 325530.0 330008.0 330468.0 330529.0 48646.5 48748.8 48835.0 48879.8 48883.8 1105.2 1223.1 1232.3 1272.5 1293.7 25692.4 28220.7 28469.3 28473.0 28897.0 39794.6 39860.4 40192.8 40245.0 40248.6 230339.0 231367.0 231607.0 231811.0 232092.0 21362.5 23904.2 24105.8 24161.5 24252.9 35691.6 36771.4 40346.4 41060.0 41148.4 34123.7 34726.8 35176.1 35636.0 35974.6 31987.0 35022.3 35077.3 35099.3 35817.0 34512.5 34668.5 34950.3 34965.5 34998.7 30823.2 31506.7 31571.7 31572.7 31642.5 24516.6 24556.8 24976.5 25102.5 25151.6 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | [#2] jquery.html Cycles:180 Average:23809.51 Median:4750.09 stddev:62931.00 (1324.8%) stddev-sans-first:63082.94 19:16:12 INFO - PROCESS | 12404 | Values: 377.6 382.2 389.9 391.1 393.8 15711.3 16425.8 16549.9 16555.8 16881.2 11784.0 15991.4 16646.7 16652.0 16704.6 4678.0 4822.2 4903.3 4914.7 4915.8 3582.9 5334.4 5642.4 5649.8 5657.7 5566.8 5625.0 5626.5 5652.4 5655.1 5412.1 5518.1 5548.1 5556.3 5557.9 3507.7 5225.6 5493.1 5521.2 5521.7 11841.5 12181.9 12298.4 12301.6 12525.4 1896.1 2253.0 2266.8 2407.8 2414.8 9066.1 9324.4 9449.5 9554.2 9723.1 1629.9 1708.5 1725.6 1730.2 1858.8 62147.7 71019.6 71051.6 71499.0 71530.6 9909.9 10064.1 10120.7 10209.9 10266.9 14126.0 14229.6 14248.2 14251.9 14252.6 6868.3 6964.5 7043.0 7061.6 7393.1 6785.0 6927.0 6982.1 7091.0 7108.0 4363.7 4439.4 4458.0 4485.0 4551.4 1733.5 1775.0 1852.7 1877.0 1915.0 812.7 837.2 863.3 885.3 986.6 15638.5 16507.8 16785.2 16964.8 17632.3 878.1 896.5 934.5 938.6 960.0 9252.2 9475.1 9801.7 9847.1 9976.7 354191.0 384298.0 384915.0 387020.0 388074.0 77501.0 81069.2 81127.6 81172.0 81333.6 962.6 974.2 979.6 990.2 996.2 15268.8 15287.4 15352.2 15449.8 15778.0 35571.3 35914.8 35920.8 36064.5 36150.1 49256.3 51515.7 51747.0 52435.2 52526.7 7823.3 7994.9 8029.4 8091.8 8232.3 11038.4 11292.4 11926.4 12268.9 12282.0 10142.4 10204.7 10632.7 10785.6 10925.9 5034.6 5553.5 8466.7 8857.4 10495.9 10393.9 10395.7 10815.2 10835.9 10912.6 7932.2 8027.2 8065.8 8110.6 8131.0 8111.4 9373.3 10464.5 10818.9 10841.0 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | [#3] mootools.html Cycles:180 Average:4954.25 Median:4852.31 stddev:2761.32 (56.9%) stddev-sans-first:2754.71 19:16:12 INFO - PROCESS | 12404 | Values: 1207.9 1449.4 1485.0 1591.0 1771.6 6169.5 7208.8 7390.4 7413.4 7419.6 7012.8 7148.5 7155.3 7163.0 7165.6 1827.7 1881.0 1884.9 2173.7 2212.4 2215.6 2293.0 2296.2 2299.2 2299.7 2157.5 2183.0 2184.5 2184.7 2200.7 1795.5 2143.7 2221.3 2232.3 2232.9 2199.4 2226.2 2228.8 2230.3 2232.1 7068.3 7144.7 7153.3 7209.1 7211.9 4189.1 4301.2 4305.8 4328.2 4355.6 2639.1 2748.5 2764.1 2770.2 2790.9 846.1 875.4 883.1 884.8 890.8 10026.0 10241.3 10243.5 10255.3 10269.5 4136.9 4169.1 4255.6 4291.7 4304.7 8815.2 8886.1 8900.7 8901.8 8908.8 4637.6 4642.4 4644.7 4646.3 4649.2 3512.4 3973.1 4137.9 4171.2 4218.0 3515.7 3523.5 3575.9 3584.9 3632.9 1173.1 1175.5 1175.7 1176.1 1184.6 747.2 756.3 841.4 845.8 861.5 4739.1 4965.5 4975.9 5078.7 5122.2 411.2 423.5 429.6 429.6 439.4 3418.7 3434.4 3501.2 3501.9 3549.2 8842.6 9153.8 9222.1 9360.0 9369.7 9230.0 9264.9 9291.1 9293.2 9300.7 6669.4 6695.9 6929.9 7011.2 7011.5 5155.8 5245.4 5276.5 5314.4 5389.9 8560.1 8566.9 8658.5 8757.0 8763.9 8562.7 8808.9 8821.1 8875.2 8925.2 5460.1 6299.3 6504.5 6593.6 6608.8 7317.1 7352.0 7435.0 7441.5 7448.3 6411.3 6556.2 6646.2 6661.5 6795.4 6599.2 6661.1 6663.5 6713.6 6725.2 6205.1 6243.3 6261.5 6270.3 6273.5 4376.2 4407.8 4480.7 4491.6 4492.8 4522.6 4526.8 4555.6 4585.1 4673.1 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | [#4] prototype.html Cycles:180 Average:4175.41 Median:4721.17 stddev:1210.39 (25.6%) stddev-sans-first:1178.27 19:16:12 INFO - PROCESS | 12404 | Values: 297.6 300.5 303.6 304.9 306.2 4667.4 4735.9 4740.9 4744.6 4754.1 4658.3 4671.3 4679.2 4686.6 4706.5 3511.1 3657.5 3658.2 3659.3 3671.7 3580.7 3663.8 3717.9 3733.8 3760.2 3655.6 3700.0 3700.9 3702.2 3729.4 3629.1 3683.4 3720.4 3723.4 3723.5 3282.7 3301.1 3303.8 3309.3 3313.2 4539.1 4554.5 4557.4 4567.5 4572.5 4238.7 4241.5 4245.3 4249.7 4254.1 4801.1 4921.2 4941.5 4960.7 4968.6 3574.8 3585.6 3593.2 3598.7 3613.6 5147.8 5148.5 5148.9 5153.8 5185.6 3562.4 3646.2 3654.3 3657.9 3682.4 3686.5 3686.7 3696.4 3705.2 3706.1 4141.6 4148.9 4156.4 4183.4 4191.3 4874.5 4883.9 4908.1 4909.7 4926.4 1303.4 1342.5 1366.9 1374.8 1377.4 916.5 927.4 932.6 936.8 938.9 4208.3 4243.3 4390.6 4391.5 4411.4 5060.2 5063.8 5080.5 5091.9 5095.8 4358.4 4366.0 4373.0 4396.6 4406.9 2790.6 2857.8 2895.9 2896.1 2915.7 5110.9 5127.6 5137.8 5145.4 5145.5 5335.4 5572.5 5575.8 5575.9 5579.1 5076.8 5077.9 5087.2 5092.5 5095.5 5373.6 5384.3 5391.3 5395.7 5427.7 4814.7 5071.5 5319.2 5350.0 5363.1 4838.9 4847.7 4860.8 4880.4 4906.9 3578.2 3623.6 3624.7 3631.1 3643.2 5000.3 5115.2 5179.3 5198.7 5201.5 4976.5 4979.7 4999.8 5021.5 5025.3 5009.8 5010.8 5013.4 5016.5 5024.5 4829.9 4936.8 4950.5 4958.0 4958.7 4766.9 4890.7 5011.8 5055.8 5063.2 4883.7 4915.0 4924.6 4926.1 4933.2 19:16:12 INFO - PROCESS | 12404 | 19:16:12 INFO - PROCESS | 12404 | [#5] yui.html Cycles:180 Average:12453.62 Median:42719.50 stddev:13572.78 (31.8%) stddev-sans-first:13582.24 19:16:12 INFO - PROCESS | 12404 | Values: 716.2 732.2 763.4 787.3 788.1 12176.3 12636.6 12677.2 12882.0 12905.8 11978.9 12041.9 12051.6 12113.2 12142.2 626.0 792.1 800.1 810.8 810.9 805.0 806.2 806.9 808.2 809.1 862.5 865.5 866.1 866.3 866.7 679.4 836.3 859.4 862.3 865.2 631.0 632.2 632.9 633.2 633.8 12443.3 12475.5 12525.1 12551.4 12570.6 12097.2 12369.4 12882.9 12995.7 13086.5 11114.2 11116.8 11199.6 11277.3 11308.4 4198.4 4231.7 4305.7 4339.4 4379.2 42446.0 42993.0 43032.4 43049.8 43175.8 9959.3 10353.7 10487.2 10593.7 10837.3 17260.1 17602.3 17612.0 18119.8 18214.9 6892.7 6913.3 7028.3 7089.1 7099.5 3757.3 3799.0 3806.5 3903.5 3919.1 2841.1 2923.6 2926.3 2926.4 2927.1 524.6 525.8 535.3 537.2 537.3 534.8 571.3 605.4 648.6 664.6 7444.6 7832.5 7836.6 7882.0 7923.2 582.1 619.8 626.3 648.5 654.0 3639.1 3698.7 3711.9 3734.0 3845.7 46047.8 48212.0 49044.8 49128.3 49140.0 43224.4 44151.6 44439.1 45712.1 45825.5 40339.8 41397.2 41414.6 41494.2 41599.0 7319.7 7447.5 7499.9 7545.7 7696.8 28342.0 28993.0 29027.3 29136.6 29490.4 33906.8 34501.5 36670.6 36684.0 36828.8 9890.0 10069.4 10554.2 10584.2 10918.7 11093.6 11185.3 11635.1 11709.6 12468.4 10680.1 10905.5 11012.7 11067.2 11126.7 10906.5 11125.2 11373.7 11673.9 11854.2 10921.3 11042.9 11043.3 11247.4 11733.2 8913.8 8948.9 9032.4 9299.1 9312.0 8890.4 8922.1 8958.2 8971.1 9137.0 19:16:12 INFO - PROCESS | 12404 | -------- Summary: end -------- 19:16:12 INFO - PROCESS | 12404 | 19:16:13 INFO - TEST-INFO | 12404: exit 0 19:16:13 INFO - TEST-OK | dromaeo_css | took 1116905ms 19:16:13 INFO - TEST-START | kraken 19:16:13 INFO - operating with platform_type : linux_ 19:16:13 INFO - Initialising browser for kraken test... 19:16:13 INFO - TEST-INFO | started process 12579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrcwkO/profile http://localhost:39081/getInfo.html) 19:16:17 INFO - PROCESS | 12579 | __metrics Screen width/height:1600/1200 19:16:17 INFO - PROCESS | 12579 | colorDepth:24 19:16:17 INFO - PROCESS | 12579 | Browser inner width/height: 1024/697 19:16:17 INFO - PROCESS | 12579 | __metrics 19:16:18 ERROR - PROCESS | 12579 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:16:18 INFO - TEST-INFO | 12579: exit 0 19:16:18 INFO - Browser initialized. 19:16:18 INFO - Running cycle 1/1 for kraken test... 19:16:18 INFO - TEST-INFO | started process 12659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfrcwkO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:16:30 INFO - PROCESS | 12659 | RSS: Main: 156237824 19:16:30 INFO - PROCESS | 12659 | 19:16:33 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-beat-detection) 19:16:34 INFO - PROCESS | 12659 | RSS: Main: 211550208 19:16:34 INFO - PROCESS | 12659 | 19:16:37 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-dft) 19:16:37 INFO - PROCESS | 12659 | RSS: Main: 196861952 19:16:37 INFO - PROCESS | 12659 | 19:16:40 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-fft) 19:16:41 INFO - PROCESS | 12659 | RSS: Main: 267534336 19:16:41 INFO - PROCESS | 12659 | 19:16:43 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39081/tests/kraken/driver.html?testName=audio-oscillator) 19:16:44 INFO - PROCESS | 12659 | RSS: Main: 175280128 19:16:44 INFO - PROCESS | 12659 | 19:16:46 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:47 INFO - PROCESS | 12659 | RSS: Main: 180043776 19:16:47 INFO - PROCESS | 12659 | 19:16:50 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39081/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:50 INFO - PROCESS | 12659 | RSS: Main: 215990272 19:16:50 INFO - PROCESS | 12659 | 19:16:54 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39081/tests/kraken/driver.html?testName=imaging-desaturate) 19:16:55 INFO - PROCESS | 12659 | RSS: Main: 216518656 19:16:55 INFO - PROCESS | 12659 | 19:16:57 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39081/tests/kraken/driver.html?testName=json-parse-financial) 19:16:58 INFO - PROCESS | 12659 | RSS: Main: 216301568 19:16:58 INFO - PROCESS | 12659 | 19:17:00 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:17:00 INFO - PROCESS | 12659 | RSS: Main: 202850304 19:17:00 INFO - PROCESS | 12659 | 19:17:02 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:17:03 INFO - PROCESS | 12659 | RSS: Main: 207159296 19:17:03 INFO - PROCESS | 12659 | 19:17:05 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:17:06 INFO - PROCESS | 12659 | RSS: Main: 217939968 19:17:06 INFO - PROCESS | 12659 | 19:17:08 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:17:09 INFO - PROCESS | 12659 | RSS: Main: 222412800 19:17:09 INFO - PROCESS | 12659 | 19:17:12 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:17:13 INFO - PROCESS | 12659 | RSS: Main: 220205056 19:17:13 INFO - PROCESS | 12659 | 19:17:14 INFO - PROCESS | 12659 | Cycle 1(1): loaded http://localhost:39081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39081/tests/kraken/driver.html?testName=ai-astar) 19:17:15 INFO - PROCESS | 12659 | RSS: Main: 283545600 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | __start_tp_report 19:17:15 INFO - PROCESS | 12659 | _x_x_mozilla_page_load 19:17:15 INFO - PROCESS | 12659 | _x_x_mozilla_page_load_details 19:17:15 INFO - PROCESS | 12659 | |i|pagename|runs| 19:17:15 INFO - PROCESS | 12659 | |0;ai-astar;113;115;109;113;114;113;104;116;116;114 19:17:15 INFO - PROCESS | 12659 | |1;audio-beat-detection;161;132;157;182;133;162;151;133;187;139 19:17:15 INFO - PROCESS | 12659 | |2;audio-dft;162;161;161;160;161;161;162;163;162;164 19:17:15 INFO - PROCESS | 12659 | |3;audio-fft;75;78;110;114;74;75;76;113;105;74 19:17:15 INFO - PROCESS | 12659 | |4;audio-oscillator;93;96;146;94;95;94;151;95;94;152 19:17:15 INFO - PROCESS | 12659 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 19:17:15 INFO - PROCESS | 12659 | |6;imaging-darkroom;146;146;145;146;146;146;146;145;145;146 19:17:15 INFO - PROCESS | 12659 | |7;imaging-desaturate;95;94;95;95;94;94;94;95;94;94 19:17:15 INFO - PROCESS | 12659 | |8;json-parse-financial;66;66;66;66;67;66;67;82;65;64 19:17:15 INFO - PROCESS | 12659 | |9;json-stringify-tinderbox;64;66;66;65;66;65;65;64;64;65 19:17:15 INFO - PROCESS | 12659 | |10;stanford-crypto-aes;80;78;79;83;80;79;79;79;79;78 19:17:15 INFO - PROCESS | 12659 | |11;stanford-crypto-ccm;131;129;132;126;127;126;128;131;220;138 19:17:15 INFO - PROCESS | 12659 | |12;stanford-crypto-pbkdf2;183;176;174;175;179;180;176;178;175;181 19:17:15 INFO - PROCESS | 12659 | |13;stanford-crypto-sha256-iterative;74;75;75;75;74;75;76;73;75;72 19:17:15 INFO - PROCESS | 12659 | __end_tp_report 19:17:15 INFO - PROCESS | 12659 | __start_cc_report 19:17:15 INFO - PROCESS | 12659 | _x_x_mozilla_cycle_collect,1871 19:17:15 INFO - PROCESS | 12659 | __end_cc_report 19:17:15 INFO - PROCESS | 12659 | __startTimestamp1461637035158__endTimestamp 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | ------- Summary: start ------- 19:17:15 INFO - PROCESS | 12659 | Number of tests: 14 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.65 (3.2%) stddev-sans-first:3.87 19:17:15 INFO - PROCESS | 12659 | Values: 113.0 115.0 109.0 113.0 114.0 113.0 104.0 116.0 116.0 114.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:159.00 stddev:19.98 (12.6%) stddev-sans-first:21.02 19:17:15 INFO - PROCESS | 12659 | Values: 161.0 132.0 157.0 182.0 133.0 162.0 151.0 133.0 187.0 139.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 19:17:15 INFO - PROCESS | 12659 | Values: 162.0 161.0 161.0 160.0 161.0 161.0 162.0 163.0 162.0 164.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#3] audio-fft Cycles:10 Average:89.40 Median:74.50 stddev:18.34 (24.6%) stddev-sans-first:18.70 19:17:15 INFO - PROCESS | 12659 | Values: 75.0 78.0 110.0 114.0 74.0 75.0 76.0 113.0 105.0 74.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:94.00 stddev:26.74 (28.4%) stddev-sans-first:27.55 19:17:15 INFO - PROCESS | 12659 | Values: 93.0 96.0 146.0 94.0 95.0 94.0 151.0 95.0 94.0 152.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:17:15 INFO - PROCESS | 12659 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 19:17:15 INFO - PROCESS | 12659 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:17:15 INFO - PROCESS | 12659 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:66.00 stddev:5.17 (7.8%) stddev-sans-first:5.45 19:17:15 INFO - PROCESS | 12659 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 82.0 65.0 64.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 19:17:15 INFO - PROCESS | 12659 | Values: 64.0 66.0 66.0 65.0 66.0 65.0 65.0 64.0 64.0 65.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.43 (1.8%) stddev-sans-first:1.50 19:17:15 INFO - PROCESS | 12659 | Values: 80.0 78.0 79.0 83.0 80.0 79.0 79.0 79.0 79.0 78.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:131.00 stddev:28.75 (22.0%) stddev-sans-first:30.36 19:17:15 INFO - PROCESS | 12659 | Values: 131.0 129.0 132.0 126.0 127.0 126.0 128.0 131.0 220.0 138.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.50 stddev:2.98 (1.7%) stddev-sans-first:2.47 19:17:15 INFO - PROCESS | 12659 | Values: 183.0 176.0 174.0 175.0 179.0 180.0 176.0 178.0 175.0 181.0 19:17:15 INFO - PROCESS | 12659 | 19:17:15 INFO - PROCESS | 12659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:75.00 stddev:1.17 (1.6%) stddev-sans-first:1.24 19:17:15 INFO - PROCESS | 12659 | Values: 74.0 75.0 75.0 75.0 74.0 75.0 76.0 73.0 75.0 72.0 19:17:15 INFO - PROCESS | 12659 | -------- Summary: end -------- 19:17:15 INFO - PROCESS | 12659 | 19:17:16 INFO - TEST-INFO | 12659: exit 0 19:17:16 INFO - TEST-OK | kraken | took 62880ms 19:17:16 INFO - SUITE-END | took 1179s 19:17:16 INFO - Completed test suite (00:19:39) 19:17:16 INFO - javascript benchmark 19:17:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.10816214325, 2615.3461634591354, 2620.842749435034, 2643.1806140096573, 2658.574628059511, 4466.6426685865135, 4543.363929049928, 4568.0, 4571.611413029892, 4576.656750743695, 4641.071785642868, 4642.303654451834, 4729.574338309551, 4735.8816029599275, 4746.430428348603, 4230.830766769325, 4268.594483524068, 4308.310670292738, 4361.542038086003, 4382.12357528494, 4340.392345071693, 4381.298992161255, 4392.143532011259, 4393.05549306899, 4408.118376324732, 4096.3855421686685, 4182.0, 4221.197972385237, 4282.8715138545895, 4307.978460107695, 4247.150569886036, 4286.39990401344, 4291.849785257501, 4312.3531470279395, 4337.587929146726, 4211.768352740598, 4251.91496170078, 4262.1049579588325, 4267.061246525759, 4292.914141717149, 4374.343848422762, 4479.10417916418, 4538.841140560065, 4572.039871626962, 4584.220682483986, 4906.9263961040615, 4918.04098200851, 4933.235348520985, 4940.925886111711, 4971.7762700678195, 4926.5812405945535, 4957.702537847741, 4959.082569724576, 4974.701517908937, 5009.674371165863, 4499.932501012455, 4655.068986202739, 4660.6970546914345, 4746.95253047472, 4756.334113224151, 5088.185890257541, 5104.979004199175, 5108.0, 5123.795048198105, 5148.819791307286, 4872.074305881871, 4892.681975671641, 4897.1185186666025, 4943.703377797344, 4946.332245146931, 4751.548602882721, 4897.41231052276, 4958.206686930074, 4964.379452568429, 5023.0, 4899.779509921991, 4904.950950490521, 4915.5330243626795, 4919.065377578248, 4948.777305021283, 4884.065859980141, 4900.436449808318, 4906.2640603909695, 4909.852704418801, 4954.232094025432, 4149.3775933609595, 4226.556211597799, 4227.217964676544, 4231.386448964883, 4295.720778149473, 3675.2649470106085, 3694.242680250542, 3708.35103856824, 3709.0727318170457, 3710.8330125143893, 4161.354989976498, 4217.7891105444605, 4249.5113061997645, 4349.108432771274, 4352.542982986804, 4943.209086546135, 4944.159492886218, 4945.505449455026, 4946.554810067111, 4991.875203119878, 4234.1108367242605, 4236.576342365739, 4242.915141697149, 4277.101808620162, 4279.7218180818145, 4371.300591905344, 4430.0, 4468.352088947085, 4533.342665313511, 4547.795349209294, 4664.626829853603, 4669.39297891272, 4684.976575117171, 4689.366935463737, 4734.692245004064, 4966.304717339648, 4976.552110310089, 4978.950210497848, 4981.875453113701, 5026.296318515338, 4425.358323043205, 4664.953350466452, 4734.19518681818, 4768.1417344878255, 4790.688605240648, 4850.320955066364, 4873.293372461044, 4875.000624871822, 4875.731834748981, 4918.5573298403315, 4828.951710482991, 4870.512948705101, 4883.389576302962, 4888.169011268022, 4920.188168952082, 4729.479757226633, 4824.204006338915, 4830.806767729392, 4853.6359773017875, 4872.512748725099, 4772.427308722976, 4811.182099043241, 4811.350467686818, 4815.783289752039, 4859.684120532154, 4593.632509399307, 4632.675712700078, 4749.762511874462, 4750.7862146202815, 4800.711957282574, 4865.294532292868, 4873.4882837301575, 4883.194272945067, 4903.828366007173, 4927.260910863256, 4768.165571025126, 4773.0, 4775.570198682135, 4778.713277203379, 4816.8073277069925], "value": 4551.3408822013325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.1948406616177, 555.2088274209251, 577.3014652270753, 596.829903477509, 603.5624172474957, 28810.711892881063, 34878.476822847675, 35116.0, 35332.64667353326, 35502.46746298801, 37618.0595485113, 38428.23143537128, 38473.807630961805, 38520.807395962984, 38565.80717096411, 7216.855662886739, 7668.731594394198, 7876.212378762107, 7891.131975482721, 9592.568334424932, 9541.427514349161, 9689.515524223796, 9717.46553939533, 9718.951405242999, 9726.124648781608, 9654.03459654036, 9812.950935245313, 9819.950900245525, 9820.459874706889, 9826.263030272758, 9673.274504412162, 9746.46394448305, 9766.951165244129, 9781.853272200922, 9789.804203915883, 9698.9515052425, 9839.80320393588, 10035.648752293708, 10035.949820250851, 10051.69844904654, 38396.61603383986, 38862.61137388618, 38864.22271554553, 38911.41632875509, 38975.0, 3027.439923614116, 3028.4548781219373, 3060.8469576521084, 3117.4544454720335, 3162.383335249627, 29601.407971840443, 29960.0, 29990.7610693317, 30057.398852023056, 30779.692203077906, 3351.9664803351898, 3351.983240083784, 3412.2151905061974, 3456.6370531094126, 3491.8428670709877, 227711.0, 228078.0, 228521.0, 228767.0, 229113.0, 55332.17001744977, 55605.165922511194, 55687.72156139275, 55706.72146639322, 55806.72096639491, 57214.71392643094, 57787.71106144526, 57788.4221157783, 57821.42178578245, 57846.13230801541, 14590.270486475634, 15122.168280744445, 15139.486051394771, 15151.621209469631, 15167.696646067237, 9781.0, 10221.437820919771, 10431.321964072311, 10449.425281609432, 10475.1096156826, 17114.20300868416, 17206.483805485856, 17207.311707531557, 17223.91388043077, 17244.741328880078, 5814.244148260699, 5936.009261292165, 5964.373740757158, 5976.850578735566, 6145.508359331243, 856.280724191682, 865.9653613855501, 935.9157675809209, 1013.9290249682451, 1031.7626945802508, 25420.618690719653, 27054.0, 27372.178834634993, 27819.16542503728, 29328.120156394914, 1016.3800081950004, 1017.3590637898225, 1019.5564929255797, 1038.2680210451613, 1097.7310558913118, 13925.930370348286, 14555.19946402958, 14570.271486425636, 14801.18593477369, 14858.554243372717, 325126.0, 325530.0, 330008.0, 330468.0, 330529.0, 48646.513534864906, 48748.75625621849, 48835.0, 48879.75560122177, 48883.75558122258, 1105.2429086076063, 1223.1499108119772, 1232.3160645841645, 1272.465564462928, 1293.7089154940252, 25692.357691057874, 28220.71779282263, 28469.288267793472, 28473.0, 28897.0, 39794.60205398025, 39860.40209396919, 40192.79903600463, 40245.0, 40248.597514024485, 230339.0, 231367.0, 231607.0, 231811.0, 232092.0, 21362.465938351666, 23904.16335428252, 24105.758942411052, 24161.51676966416, 24252.87873560621, 35691.64308356987, 36771.44842827413, 40346.394804077376, 41060.0, 41148.38277425901, 34123.65876341205, 34726.82636586801, 35176.12059698528, 35636.0, 35974.64025359713, 31987.0, 35022.29955400929, 35077.298454030264, 35099.29801404009, 35817.0, 34512.48231276483, 34668.47997279993, 34950.30099397947, 34965.47551786776, 34998.65001349954, 30823.2294192647, 31506.684933151293, 31571.684283156876, 31572.684273156974, 31642.525362120046, 24516.6322505159, 24556.754432455447, 24976.50046999086, 25102.49795004053, 25151.622725658763], "value": 17419.24715811464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5733421234006, 382.19738549047, 389.9044734040161, 391.0809597446002, 393.84246301479425, 15711.292991815368, 16425.75361369579, 16549.924254923422, 16555.83444165558, 16881.155942202902, 11784.0, 15991.360345586163, 16646.66706665869, 16652.0, 16704.58238544037, 4677.999999999992, 4822.180229361017, 4903.289023091667, 4914.729689867056, 4915.754212289389, 3582.8566857325804, 5334.386545547273, 5642.351129620085, 5649.830505084854, 5657.688827114507, 5566.832995010156, 5624.971875140619, 5626.521745651625, 5652.434756524356, 5655.095184770437, 5412.079946409101, 5518.117101263819, 5548.056830338852, 5556.305461817273, 5557.944420555803, 3507.736919731005, 5225.634205605609, 5493.121100623921, 5521.199426083195, 5521.668699878021, 11841.526338946433, 12181.878181218162, 12298.446569904376, 12301.630951071482, 12525.37373131349, 1896.0614495824518, 2253.042456955787, 2266.784655457729, 2407.831451798375, 2414.770596793302, 9066.093390660948, 9324.440533568008, 9449.527523623792, 9554.23566114716, 9723.076307750753, 1629.9429519966745, 1708.5386945524763, 1725.620363520036, 1730.2041061111904, 1858.8327050565515, 62147.6892615534, 71019.64490177516, 71051.64474177647, 71498.99999999948, 71530.64234678846, 9909.900900991042, 10064.068606382965, 10120.74698132538, 10209.9489502552, 10266.897331026743, 14126.0, 14229.573112806633, 14248.216348100954, 14251.928740356232, 14252.643683907985, 6868.278830722702, 6964.547304425196, 7043.0, 7061.576305421691, 7393.112826460859, 6785.0, 6926.965365173141, 6982.1272340957385, 7091.042709234291, 7107.964460177769, 4363.738175709467, 4439.378487011821, 4457.955420445819, 4484.977575112103, 4551.431071116111, 1733.4539620019652, 1775.0, 1852.740616313717, 1876.981230187708, 1914.9904250478658, 812.6505602590943, 837.2422957223722, 863.2532859076854, 885.2829208341265, 986.5609803637456, 15638.452654157278, 16507.83492165087, 16785.160741962853, 16964.83035169657, 17632.294708211528, 878.1350369885657, 896.5069211933411, 934.4768028114266, 938.638624129715, 959.9760005999906, 9252.213561847184, 9475.147236748726, 9801.656942007137, 9847.064528869745, 9976.650817221362, 354191.0, 384298.0, 384915.0, 387020.0, 388074.0, 77501.0, 81069.18930810735, 81127.59436202899, 81172.0, 81333.59333203296, 962.5620342744035, 974.1846064872524, 979.5543027922279, 990.2276224544867, 996.2030375699411, 15268.770968435705, 15287.388504459697, 15352.155631440379, 15449.84550154484, 15778.0, 35571.288574228885, 35914.820425897706, 35920.844749315125, 36064.45903311505, 36150.107991361154, 49256.261156083405, 51515.74242128765, 51747.0, 52435.213471798714, 52526.737366312926, 7823.2567906048835, 7994.920050799417, 8029.397795165269, 8091.83816323682, 8232.259096681328, 11038.448077595927, 11292.378919159524, 11926.403679815801, 12268.938655306667, 12282.0, 10142.442165680959, 10204.744881378025, 10632.734181645521, 10785.62250321235, 10925.890741092806, 5034.622403319839, 5553.4724201200825, 8466.70366537193, 8857.424267422597, 10495.947520262349, 10393.896061039595, 10395.740106497398, 10815.188860835311, 10835.891641083803, 10912.61805836792, 7932.206779322021, 8027.1972802719265, 8065.83868322642, 8110.600916356237, 8130.959345203236, 8111.391645626483, 9373.25013998892, 10464.529096190538, 10818.945905270422, 10840.970107839743], "value": 8102.582599477009, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.9033677305817, 1449.4129877399653, 1485.0347274271726, 1590.984090159098, 1771.627958128793, 6169.506439484841, 7208.819779505508, 7390.408767298617, 7413.369863561604, 7419.629018549072, 7012.754553590626, 7148.463865210104, 7155.284471552855, 7163.032990546275, 7165.641717914096, 1827.6892928202171, 1880.9717854232197, 1884.9057547122657, 2173.663082222254, 2212.358416059341, 2215.6122678531274, 2292.9541409171807, 2296.196331284054, 2299.218265789631, 2299.7470278269375, 2157.5037741319506, 2182.978170218293, 2184.497565559914, 2184.737831460227, 2200.680901269323, 1795.5331613780381, 2143.710599069121, 2221.3224966385246, 2232.2968264996475, 2232.9330120096506, 2199.43914301852, 2226.1874415838265, 2228.810551103158, 2230.342049095521, 2232.1294695068937, 7068.3285087916565, 7144.714211431537, 7153.320434558708, 7209.134903811524, 7211.855762884766, 4189.05746207104, 4301.247281725717, 4305.763183024932, 4328.199283132599, 4355.629771469429, 2639.129087401172, 2748.491529067109, 2764.115483045426, 2770.1966429735353, 2790.860456977143, 846.0777752250016, 875.4484674654926, 883.0595415882065, 884.8363052835182, 890.7505898348472, 10026.0, 10241.334313269688, 10243.53904074311, 10255.333403328834, 10269.486525673761, 4136.883041578757, 4169.145325208325, 4255.553166917491, 4291.742495450283, 4304.74171549708, 8815.206631403205, 8886.066962968924, 8900.732978010541, 8901.821963560693, 8908.777280568038, 4637.582617564368, 4642.442906851199, 4644.651651126179, 4646.279826626878, 4649.232876575327, 3512.350215210194, 3973.106051138471, 4137.937930931039, 4171.249175148502, 4217.957820421757, 3515.736319776027, 3523.5067090607336, 3575.9284814304087, 3584.946225806615, 3632.8728494503093, 1173.137743758337, 1175.488662431845, 1175.7295821960997, 1176.1355403778216, 1184.6209213051914, 747.2340850628041, 756.2588663110073, 841.4068082002174, 845.8308338332358, 861.5347712235448, 4739.123262196505, 4965.503449655005, 4975.90048199034, 5078.695278283241, 5122.154844450699, 411.22278892892456, 423.45585922089964, 429.58665988896803, 429.60047156145083, 439.41338313351395, 3418.743594230393, 3434.364642541138, 3501.1947252132154, 3501.9474707879403, 3549.165946002687, 8842.602082906285, 9153.81692366149, 9222.123898229658, 9360.0, 9369.672061477815, 9230.0, 9264.861027084598, 9291.117343852324, 9293.163615274658, 9300.674476393293, 6669.399754022162, 6695.866082678319, 6929.930700693029, 7011.193712723, 7011.5091943564485, 5155.819546316011, 5245.396779370421, 5276.472352764693, 5314.362276526842, 5389.892202156013, 8560.143985601639, 8566.871496927675, 8658.48049117055, 8756.956215218883, 8763.868541971748, 8562.700305489278, 8808.91191088081, 8821.117888211127, 8875.245604123464, 8925.152110549487, 5460.071787796163, 6299.307076221704, 6504.512161587805, 6593.571417857824, 6608.834779130368, 7317.121945366377, 7352.0, 7435.0, 7441.516301440389, 7448.329650331496, 6411.326810684811, 6556.213254409501, 6646.169228846395, 6661.500387470862, 6795.354441328066, 6599.175103112111, 6661.067450557023, 6663.533552651462, 6713.597184168965, 6725.19297684281, 6205.100260462298, 6243.313235544178, 6261.467775239155, 6270.278917924497, 6273.52948528853, 4376.212281789309, 4407.823687052611, 4480.731156130642, 4491.550844915482, 4492.842750503717, 4522.5929666330185, 4526.796294166837, 4555.589996900162, 4585.082983403399, 4673.112108699336], "value": 3947.1238849432393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6353966391171, 300.5206695320963, 303.5931851319232, 304.932914758753, 306.19318096814885, 4667.432911898455, 4735.857924262269, 4740.9288860667075, 4744.620430365571, 4754.120487709776, 4658.346287068093, 4671.252599584067, 4679.204535229011, 4686.625069994401, 4706.4822869484415, 3511.0682580045627, 3657.5128912339596, 3658.1769101952113, 3659.323025240326, 3671.6695497405226, 3580.6598373154507, 3663.798491083003, 3717.8512859485586, 3733.7573057751297, 3760.1539653578, 3655.597884232732, 3700.0009997300713, 3700.907477313062, 3702.1670124222105, 3729.403295472725, 3629.0745859805843, 3683.355412802749, 3720.3675375186417, 3723.422869455239, 3723.478712980185, 3282.688144626257, 3301.1417031571723, 3303.7687361884678, 3309.3050459403553, 3313.2379552703014, 4539.0921815636675, 4554.521775213621, 4557.361969324297, 4567.497575266718, 4572.51988541205, 4238.682098842568, 4241.533431322552, 4245.299525578276, 4249.681273904439, 4254.08537164508, 4801.135795556798, 4921.237208232729, 4941.45643979162, 4960.677555958851, 4968.6025117990475, 3574.767640103411, 3585.551806024247, 3593.1735700788963, 3598.7300952428673, 3613.5844377896615, 5147.819826306099, 5148.502976056609, 5148.948510514884, 5153.819616313411, 5185.55922746567, 3562.3943929532043, 3646.21606354635, 3654.3239500691925, 3657.9268414632093, 3682.429223470366, 3686.4838922550866, 3686.668199862025, 3696.4085746281003, 3705.2404257127223, 3706.09200745819, 4141.565135660772, 4148.91702165961, 4156.376543518496, 4183.372494125905, 4191.287481128215, 4874.512548745168, 4883.875514151285, 4908.141075311878, 4909.68087074339, 4926.448168826808, 1303.3548393545257, 1342.5435351980373, 1366.9179849209079, 1374.8075269462283, 1377.4008306386554, 916.5325683901258, 927.3832901120815, 932.5616960028775, 936.7611259128879, 938.9154976052051, 4208.263553878059, 4243.342281946303, 4390.626796722315, 4391.538888416734, 4411.448568928884, 5060.2156665716875, 5063.8480845574695, 5080.466551012164, 5091.872703182376, 5095.847124586268, 4358.3680366347335, 4366.039471316305, 4373.0, 4396.582324679151, 4406.911861762746, 2790.5674620433865, 2857.7570906472765, 2895.8552072396296, 2896.102208315429, 2915.7230063143966, 5110.897782044412, 5127.564157046618, 5137.790749977471, 5145.408278048072, 5145.4597267287145, 5335.359756829128, 5572.498475137176, 5575.832725018256, 5575.944240557624, 5579.079451890392, 5076.771545280471, 5077.923831142536, 5087.186050232019, 5092.541671249605, 5095.464976177596, 5373.596980226421, 5384.326959130109, 5391.29913111293, 5395.70323632204, 5427.728613569385, 4814.6870453420415, 5071.467495912876, 5319.202119682079, 5350.0, 5363.115086010921, 4838.903221935471, 4847.660663753503, 4860.756962151949, 4880.41435027799, 4906.8773280668265, 3578.177019285527, 3623.6376362363553, 3624.710023198085, 3631.0755299691205, 3643.1620727232353, 5000.324956130876, 5115.2071428928575, 5179.30079439286, 5198.740062996911, 5201.540975251415, 4976.477469865612, 4979.726115063706, 4999.825006124768, 5021.472745361684, 5025.296458495741, 5009.799608015638, 5010.774515146754, 5013.448520662651, 5016.473270306711, 5024.522670346311, 4829.903401932012, 4936.827211047596, 4950.480199578992, 4958.0, 4958.727240021569, 4766.856994290177, 4890.70396344976, 5011.824586139468, 5055.823046193365, 5063.1645778446145, 4883.731394773322, 4914.950850491449, 4924.630652701134, 4926.113299606105, 4933.21068629032], "value": 3801.2521774819106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.2050124361957, 732.2018999290774, 763.4465012865674, 787.2993036197785, 788.1330536409946, 12176.269423834576, 12636.557720479785, 12677.239365638045, 12882.0, 12905.80641290379, 11978.880211197886, 12041.879581204184, 12051.578194763186, 12113.212641178317, 12142.210756300834, 625.9937400626004, 792.128658475675, 800.0599295827394, 810.7689308547066, 810.9026916769996, 804.951702897825, 806.2139414071263, 806.9152738962383, 808.1837344282288, 809.0614886731393, 862.5169904853302, 865.4634126841368, 866.1295398124876, 866.2766589897411, 866.6749968761715, 679.4428568573771, 836.3267569606464, 859.4413631139747, 862.2799962031711, 865.2299453486402, 630.9652969086699, 632.1844820182006, 632.9398707122816, 633.2274624957545, 633.7560039384824, 12443.25340479565, 12475.50097996079, 12525.060620453502, 12551.435185416678, 12570.622881313575, 12097.185422186654, 12369.443375048144, 12882.935585322108, 12995.740085198338, 13086.541971031063, 11114.22200445969, 11116.777664446747, 11199.60801371948, 11277.266977646426, 11308.37803920784, 4198.412222288882, 4231.682623803227, 4305.698601097924, 4339.414179085815, 4379.189849877783, 42446.0, 42993.0, 43032.35451468199, 43049.78475107636, 43175.784121079196, 9959.302848800658, 10353.689389318333, 10487.213458990605, 10593.682189534326, 10837.349759014327, 17260.136993150543, 17602.29590816353, 17612.0, 18119.818801812078, 18214.90892545529, 6892.724291028403, 6913.343232392915, 7028.297170283033, 7089.113860767404, 7099.538529995534, 3757.323681737259, 3798.9620103798607, 3806.5051543299746, 3903.4730311408166, 3919.118198405336, 2841.0766500887294, 2923.6053132826796, 2926.268432891777, 2926.4000879819587, 2927.107232294171, 524.6490287509678, 525.7528961388141, 535.253321616343, 537.1834811087126, 537.2612657595806, 534.767376191358, 571.3172758553488, 605.379486026826, 648.5751832549688, 664.5647101148755, 7444.553326800409, 7832.530048197126, 7836.608169591497, 7882.0, 7923.217276112944, 582.135528739821, 619.7923695561947, 626.2547568393597, 648.5427773419727, 654.0385633119307, 3639.1266096136737, 3698.6671199592165, 3711.9443208351895, 3734.0291524203903, 3845.692344612424, 46047.76976115098, 48212.0, 49044.75477622589, 49128.26307605389, 49140.0, 43224.351634725506, 44151.558484415385, 44439.11121777546, 45712.08575828465, 45825.54174458213, 40339.798301008894, 41397.1720565587, 41414.58585414107, 41494.170116597496, 41599.0, 7319.670614822239, 7447.478676492594, 7499.925000749922, 7545.698172073276, 7696.807579810549, 28342.0, 28993.0, 29027.274318142216, 29136.56295155532, 29490.410191796473, 33906.83046584751, 34501.48247776235, 36670.633293666724, 36684.0, 36828.81585592055, 9889.950550247202, 10069.395836249849, 10554.2084343673, 10584.206184536037, 10918.672439826818, 11093.5562577496, 11185.32888026721, 11635.127365447455, 11709.648710538697, 12468.376581171087, 10680.092192163442, 10905.509252083833, 11012.724681883017, 11067.225294229327, 11126.721831954266, 10906.50920708554, 11125.221234513507, 11373.715657108638, 11673.883261167279, 11854.170208085696, 10921.290116142425, 11042.889571104186, 11043.282186657842, 11247.381394023407, 11733.237339573241, 8913.821723565623, 8948.910510894808, 9032.367734258802, 9299.116583924517, 9312.022237664947, 8890.377673562789, 8922.107789221025, 8958.238549723346, 8971.147740964598, 9137.0], "value": 5970.202094521878, "unit": "score"}], "name": "dromaeo_css", "value": 6213.553554074416, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 109.0, 113.0, 114.0, 113.0, 104.0, 116.0, 116.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 157.0, 182.0, 133.0, 162.0, 151.0, 133.0, 187.0, 139.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 163.0, 162.0, 164.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 110.0, 114.0, 74.0, 75.0, 76.0, 113.0, 105.0, 74.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 146.0, 94.0, 95.0, 94.0, 151.0, 95.0, 94.0, 152.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 82.0, 65.0, 64.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 83.0, 80.0, 79.0, 79.0, 79.0, 79.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 132.0, 126.0, 127.0, 126.0, 128.0, 131.0, 220.0, 138.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 176.0, 174.0, 175.0, 179.0, 180.0, 176.0, 178.0, 175.0, 181.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 75.0, 74.0, 75.0, 76.0, 73.0, 75.0, 72.0], "value": 74.4, "unit": "score"}], "name": "kraken", "value": 1588.2000000000003, "alertThreshold": 2.0}]} 19:17:16 INFO - Return code: 0 19:17:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:17:16 ERROR - # TBPL SUCCESS # 19:17:16 INFO - Running post-action listener: _resource_record_post_action 19:17:16 INFO - Running post-run listener: _resource_record_post_run 19:17:17 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393687040; Read time: 12; Write time: 269624 19:17:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110469120; Read time: 0; Write time: 74096 19:17:17 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283217920; Read time: 12; Write time: 195528 19:17:17 INFO - Running post-run listener: _upload_blobber_files 19:17:17 INFO - Blob upload gear active. 19:17:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:17:17 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 19:17:17 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'] 19:17:17 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 19:17:17 INFO - (blobuploader) - INFO - Open directory for files ... 19:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:19 INFO - (blobuploader) - INFO - Done attempting. 19:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:19 INFO - (blobuploader) - INFO - Done attempting. 19:17:19 INFO - (blobuploader) - INFO - Iteration through files over. 19:17:19 INFO - Return code: 0 19:17:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:17:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:17:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1caba5d0b576c3c6ebd074b80bea729de3f414c0d01747dc97e4b7e40d8461bcd71f4f0558dfcf1f62d5c0cf6268cd921e37025d5a19c36892724bc55be7ac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e0594a33186b6d9aa37cac1c2c91370caecf46e2945d336e348572ac93e3099a40f024721f236e43ad954d19f579688f2efbff034cf414d4fbfc87bb1e1a56"} 19:17:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:17:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:17:19 INFO - Contents: 19:17:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1caba5d0b576c3c6ebd074b80bea729de3f414c0d01747dc97e4b7e40d8461bcd71f4f0558dfcf1f62d5c0cf6268cd921e37025d5a19c36892724bc55be7ac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e0594a33186b6d9aa37cac1c2c91370caecf46e2945d336e348572ac93e3099a40f024721f236e43ad954d19f579688f2efbff034cf414d4fbfc87bb1e1a56"} 19:17:19 INFO - Running post-run listener: copy_logs_to_upload_dir 19:17:19 INFO - Copying logs to upload dir... 19:17:19 INFO - mkdir: /builds/slave/test/build/upload/logs 19:17:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.493221 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-25 19:17:18.969489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 19:17:18.973188) ========= 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=0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1caba5d0b576c3c6ebd074b80bea729de3f414c0d01747dc97e4b7e40d8461bcd71f4f0558dfcf1f62d5c0cf6268cd921e37025d5a19c36892724bc55be7ac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e0594a33186b6d9aa37cac1c2c91370caecf46e2945d336e348572ac93e3099a40f024721f236e43ad954d19f579688f2efbff034cf414d4fbfc87bb1e1a56"} build_url:https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/Ms77vRnCSv2oaDqbmicUrw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1caba5d0b576c3c6ebd074b80bea729de3f414c0d01747dc97e4b7e40d8461bcd71f4f0558dfcf1f62d5c0cf6268cd921e37025d5a19c36892724bc55be7ac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60e0594a33186b6d9aa37cac1c2c91370caecf46e2945d336e348572ac93e3099a40f024721f236e43ad954d19f579688f2efbff034cf414d4fbfc87bb1e1a56"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 19:17:18.998029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:17:18.998363) ========= 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=0333a256a5e4f052382dd180000001b1-1461635228.56154-1157221161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 19:17:19.081094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 19:17:19.081431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 19:17:19.081741) ========= ========= Total master_lag: 0.17 =========