builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1461470921.06 results: success (0) buildid: 20160423200647 builduid: e22b5d514c594dfea2eb74cda23d211c revision: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.063979) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.064388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.064658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.087069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.087345) ========= 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=4300f881736b422476174874000001bc-1461463055.639292-1051849193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 21:08:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-04-23 21:08:41 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.219905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.220363) ========= 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=4300f881736b422476174874000001bc-1461463055.639292-1051849193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022710 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:41.279336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 21:08:41.279892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ef9c1cc0a76ca05d459cda0a0d74266f5d916341 --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 ef9c1cc0a76ca05d459cda0a0d74266f5d916341 --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=4300f881736b422476174874000001bc-1461463055.639292-1051849193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 21:08:41,916 truncating revision to first 12 chars 2016-04-23 21:08:41,916 Setting DEBUG logging. 2016-04-23 21:08:41,916 attempt 1/10 2016-04-23 21:08:41,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ef9c1cc0a76c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 21:08:42,639 unpacking tar archive at: fx-team-ef9c1cc0a76c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.144095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 21:08:42.440043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:42.440305) ========= script_repo_revision: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:42.440643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:42.440914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:42.450867) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-23 21:08:42.451169) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1461463055.639292-1051849193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:08:43 INFO - MultiFileLogger online at 20160423 21:08:43 in /builds/slave/test 21:08:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:08:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:08:43 INFO - {'append_to_log': False, 21:08:43 INFO - 'base_work_dir': '/builds/slave/test', 21:08:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:08:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:08:43 INFO - 'branch': 'Fx-Team-Non-PGO', 21:08:43 INFO - 'buildbot_json_path': 'buildprops.json', 21:08:43 INFO - 'config_files': ('talos/linux_config.py',), 21:08:43 INFO - 'default_actions': ('clobber', 21:08:43 INFO - 'read-buildbot-config', 21:08:43 INFO - 'download-and-extract', 21:08:43 INFO - 'populate-webroot', 21:08:43 INFO - 'create-virtualenv', 21:08:43 INFO - 'install', 21:08:43 INFO - 'run-tests'), 21:08:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:08:43 INFO - 'download_minidump_stackwalk': True, 21:08:43 INFO - 'download_symbols': 'ondemand', 21:08:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:08:43 INFO - 'tooltool.py': '/tools/tooltool.py', 21:08:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:08:43 INFO - '/tools/misc-python/virtualenv.py')}, 21:08:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:08:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:08:43 INFO - 'installer_path': 'installer.exe', 21:08:43 INFO - 'log_level': 'info', 21:08:43 INFO - 'log_name': 'talos', 21:08:43 INFO - 'log_to_console': True, 21:08:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:08:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:08:43 INFO - 'opt_config_files': (), 21:08:43 INFO - 'pip_index': False, 21:08:43 INFO - 'sps_profile': False, 21:08:43 INFO - 'sps_profile_interval': 0, 21:08:43 INFO - 'suite': 'dromaeojs-e10s', 21:08:43 INFO - 'system_bits': '32', 21:08:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:08:43 INFO - 'title': 'talos-linux64-ix-045', 21:08:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:08:43 INFO - 'use_talos_json': True, 21:08:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:08:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:08:43 INFO - 'work_dir': 'build'} 21:08:43 INFO - ##### 21:08:43 INFO - ##### Running clobber step. 21:08:43 INFO - ##### 21:08:43 INFO - Running pre-action listener: _resource_record_pre_action 21:08:43 INFO - Running main action method: clobber 21:08:43 INFO - rmtree: /builds/slave/test/build 21:08:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:08:43 INFO - Running post-action listener: _resource_record_post_action 21:08:43 INFO - ##### 21:08:43 INFO - ##### Running read-buildbot-config step. 21:08:43 INFO - ##### 21:08:43 INFO - Running pre-action listener: _resource_record_pre_action 21:08:43 INFO - Running main action method: read_buildbot_config 21:08:43 INFO - Using buildbot properties: 21:08:43 INFO - { 21:08:43 INFO - "project": "", 21:08:43 INFO - "product": "firefox", 21:08:43 INFO - "script_repo_revision": "production", 21:08:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:08:43 INFO - "repository": "", 21:08:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 21:08:43 INFO - "buildid": "20160423200647", 21:08:43 INFO - "pgo_build": "False", 21:08:43 INFO - "basedir": "/builds/slave/test", 21:08:43 INFO - "buildnumber": 1435, 21:08:43 INFO - "slavename": "talos-linux64-ix-045", 21:08:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:08:43 INFO - "platform": "ubuntu64_hw", 21:08:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:08:43 INFO - "branch": "fx-team", 21:08:43 INFO - "repo_path": "integration/fx-team", 21:08:43 INFO - "revision": "ef9c1cc0a76ca05d459cda0a0d74266f5d916341", 21:08:43 INFO - "stage_platform": "linux64", 21:08:43 INFO - "builduid": "e22b5d514c594dfea2eb74cda23d211c", 21:08:43 INFO - "slavebuilddir": "test" 21:08:43 INFO - } 21:08:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:08:43 INFO - Running post-action listener: _resource_record_post_action 21:08:43 INFO - ##### 21:08:43 INFO - ##### Running download-and-extract step. 21:08:43 INFO - ##### 21:08:43 INFO - Running pre-action listener: _resource_record_pre_action 21:08:43 INFO - Running main action method: download_and_extract 21:08:43 INFO - mkdir: /builds/slave/test/build/tests 21:08: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')]} 21:08:43 INFO - https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:08:44 INFO - Downloaded 1361 bytes. 21:08:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:08:44 INFO - Using the following test package requirements: 21:08:44 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:08:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:08:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'jsshell-linux-x86_64.zip'], 21:08:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:08:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:08:44 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:08:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:08:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:08:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:44 INFO - https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:08:46 INFO - Downloaded 22285608 bytes. 21:08:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:08:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:08:47 INFO - Return code: 0 21:08:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:47 INFO - https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:08:48 INFO - Downloaded 22285608 bytes. 21:08:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:08:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:08:50 INFO - Return code: 0 21:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:50 INFO - https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:08:51 INFO - Downloaded 10840145 bytes. 21:08:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:08:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:08:51 INFO - Return code: 0 21:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:51 INFO - https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:08:56 INFO - Downloaded 54743100 bytes. 21:08:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:08:56 INFO - mkdir: /builds/slave/test/properties 21:08:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:08:56 INFO - Writing to file /builds/slave/test/properties/build_url 21:08:56 INFO - Contents: 21:08:56 INFO - build_url:https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:08:58 INFO - Running post-action listener: _resource_record_post_action 21:08:58 INFO - Running post-action listener: set_extra_try_arguments 21:08:58 INFO - ##### 21:08:58 INFO - ##### Running populate-webroot step. 21:08:58 INFO - ##### 21:08:58 INFO - Running pre-action listener: _resource_record_pre_action 21:08:58 INFO - Running main action method: populate_webroot 21:08:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:08:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:08:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:08:58 INFO - '--tppagecycles', 21:08:58 INFO - '7'], 21:08:58 INFO - 'tests': ['tsvgm']}}, 21:08:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:08:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:08:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:08:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:08:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['damp', 'tps']}, 21:08:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'tests': ['damp', 'tps']}, 21:08:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['dromaeo_dom']}, 21:08:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:08:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['a11yr', 21:08:58 INFO - 'ts_paint', 21:08:58 INFO - 'tpaint', 21:08:58 INFO - 'sessionrestore', 21:08:58 INFO - 'sessionrestore_no_auto_restore', 21:08:58 INFO - 'tabpaint']}, 21:08:58 INFO - 'other-e10s': {'tests': ['a11yr', 21:08:58 INFO - 'ts_paint', 21:08:58 INFO - 'tpaint', 21:08:58 INFO - 'sessionrestore', 21:08:58 INFO - 'sessionrestore_no_auto_restore', 21:08:58 INFO - 'tabpaint']}, 21:08:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:08:58 INFO - 'ts_paint', 21:08:58 INFO - 'tpaint', 21:08:58 INFO - 'sessionrestore', 21:08:58 INFO - 'sessionrestore_no_auto_restore', 21:08:58 INFO - 'tabpaint']}, 21:08:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:08:58 INFO - 'ts_paint', 21:08:58 INFO - 'tpaint', 21:08:58 INFO - 'sessionrestore', 21:08:58 INFO - 'sessionrestore_no_auto_restore', 21:08:58 INFO - 'tabpaint']}, 21:08:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['a11yr', 21:08:58 INFO - 'ts_paint', 21:08:58 INFO - 'tpaint', 21:08:58 INFO - 'sessionrestore', 21:08:58 INFO - 'sessionrestore_no_auto_restore', 21:08:58 INFO - 'tabpaint']}, 21:08:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['a11yr', 21:08:58 INFO - 'ts_paint', 21:08:58 INFO - 'tpaint', 21:08:58 INFO - 'sessionrestore', 21:08:58 INFO - 'sessionrestore_no_auto_restore', 21:08:58 INFO - 'tabpaint']}, 21:08:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['tsvgx', 21:08:58 INFO - 'tsvgr_opacity', 21:08:58 INFO - 'tart', 21:08:58 INFO - 'tscrollx', 21:08:58 INFO - 'cart']}, 21:08:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:08:58 INFO - 'tsvgr_opacity', 21:08:58 INFO - 'tart', 21:08:58 INFO - 'tscrollx', 21:08:58 INFO - 'cart']}, 21:08:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'talos_options': ['--disable-e10s'], 21:08:58 INFO - 'tests': ['tp5o']}, 21:08:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'tests': ['tp5o']}, 21:08:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'talos_options': ['--disable-e10s', 21:08:58 INFO - '--xperf_path', 21:08:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:58 INFO - 'tests': ['tp5n']}, 21:08:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:58 INFO - 'talos_options': ['--xperf_path', 21:08:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:58 INFO - 'tests': ['tp5n']}}, 21:08:58 INFO - 'talos.zip': {'path': '', 21:08:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:08:58 INFO - Running post-action listener: _resource_record_post_action 21:08:58 INFO - ##### 21:08:58 INFO - ##### Running create-virtualenv step. 21:08:58 INFO - ##### 21:08:58 INFO - Running pre-action listener: _resource_record_pre_action 21:08:58 INFO - Running main action method: create_virtualenv 21:08:58 INFO - Creating virtualenv /builds/slave/test/build/venv 21:08:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:08:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:08:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:08:58 INFO - Using real prefix '/usr' 21:08:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:09:00 INFO - Installing pip.................done. 21:09:00 INFO - Return code: 0 21:09:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09: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', 'pip>=1.5'] in /builds/slave/test/build 21:09: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 pip>=1.5 21:09:00 INFO - Using env: {'DISPLAY': ':0', 21:09:00 INFO - 'HOME': '/home/cltbld', 21:09:00 INFO - 'LANG': 'en_US.UTF-8', 21:09:00 INFO - 'LANGUAGE': 'en_US:en', 21:09:00 INFO - 'LOGNAME': 'cltbld', 21:09:00 INFO - 'MAIL': '/var/mail/cltbld', 21:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:00 INFO - 'MOZ_NO_REMOTE': '1', 21:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:00 INFO - 'NO_EM_RESTART': '1', 21:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:00 INFO - 'PWD': '/builds/slave/test', 21:09:00 INFO - 'SHELL': '/bin/bash', 21:09:00 INFO - 'SHLVL': '1', 21:09:00 INFO - 'TERM': 'linux', 21:09:00 INFO - 'TMOUT': '86400', 21:09:00 INFO - 'USER': 'cltbld', 21:09:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:00 INFO - '_': '/tools/buildbot/bin/python'} 21:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:09:01 INFO - Cleaning up... 21:09:01 INFO - Return code: 0 21:09:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:01 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:09:01 INFO - Using env: {'DISPLAY': ':0', 21:09:01 INFO - 'HOME': '/home/cltbld', 21:09:01 INFO - 'LANG': 'en_US.UTF-8', 21:09:01 INFO - 'LANGUAGE': 'en_US:en', 21:09:01 INFO - 'LOGNAME': 'cltbld', 21:09:01 INFO - 'MAIL': '/var/mail/cltbld', 21:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:01 INFO - 'MOZ_NO_REMOTE': '1', 21:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:01 INFO - 'NO_EM_RESTART': '1', 21:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:01 INFO - 'PWD': '/builds/slave/test', 21:09:01 INFO - 'SHELL': '/bin/bash', 21:09:01 INFO - 'SHLVL': '1', 21:09:01 INFO - 'TERM': 'linux', 21:09:01 INFO - 'TMOUT': '86400', 21:09:01 INFO - 'USER': 'cltbld', 21:09:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:01 INFO - '_': '/tools/buildbot/bin/python'} 21:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:01 INFO - Downloading/unpacking psutil>=0.7.1 21:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:03 INFO - Installing collected packages: psutil 21:09:03 INFO - Running setup.py install for psutil 21:09:03 INFO - building 'psutil._psutil_linux' extension 21:09:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:09:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:09:03 INFO - building 'psutil._psutil_posix' extension 21:09:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:09:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:03 INFO - Successfully installed psutil 21:09:03 INFO - Cleaning up... 21:09:03 INFO - Return code: 0 21:09:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:09:03 INFO - Using env: {'DISPLAY': ':0', 21:09:03 INFO - 'HOME': '/home/cltbld', 21:09:03 INFO - 'LANG': 'en_US.UTF-8', 21:09:03 INFO - 'LANGUAGE': 'en_US:en', 21:09:03 INFO - 'LOGNAME': 'cltbld', 21:09:03 INFO - 'MAIL': '/var/mail/cltbld', 21:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:03 INFO - 'MOZ_NO_REMOTE': '1', 21:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:03 INFO - 'NO_EM_RESTART': '1', 21:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:03 INFO - 'PWD': '/builds/slave/test', 21:09:03 INFO - 'SHELL': '/bin/bash', 21:09:03 INFO - 'SHLVL': '1', 21:09:03 INFO - 'TERM': 'linux', 21:09:03 INFO - 'TMOUT': '86400', 21:09:03 INFO - 'USER': 'cltbld', 21:09:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:03 INFO - '_': '/tools/buildbot/bin/python'} 21:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:09:05 INFO - Installing collected packages: mozsystemmonitor 21:09:05 INFO - Running setup.py install for mozsystemmonitor 21:09:06 INFO - Successfully installed mozsystemmonitor 21:09:06 INFO - Cleaning up... 21:09:06 INFO - Return code: 0 21:09:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:06 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:09:06 INFO - Using env: {'DISPLAY': ':0', 21:09:06 INFO - 'HOME': '/home/cltbld', 21:09:06 INFO - 'LANG': 'en_US.UTF-8', 21:09:06 INFO - 'LANGUAGE': 'en_US:en', 21:09:06 INFO - 'LOGNAME': 'cltbld', 21:09:06 INFO - 'MAIL': '/var/mail/cltbld', 21:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:06 INFO - 'MOZ_NO_REMOTE': '1', 21:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:06 INFO - 'NO_EM_RESTART': '1', 21:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:06 INFO - 'PWD': '/builds/slave/test', 21:09:06 INFO - 'SHELL': '/bin/bash', 21:09:06 INFO - 'SHLVL': '1', 21:09:06 INFO - 'TERM': 'linux', 21:09:06 INFO - 'TMOUT': '86400', 21:09:06 INFO - 'USER': 'cltbld', 21:09:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:06 INFO - '_': '/tools/buildbot/bin/python'} 21:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - Downloading docopt-0.6.1.tar.gz 21:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:08 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:08 INFO - Running setup.py install for blobuploader 21:09:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:09 INFO - Running setup.py install for requests 21:09:09 INFO - Running setup.py install for docopt 21:09:09 INFO - Successfully installed blobuploader requests docopt 21:09:09 INFO - Cleaning up... 21:09:09 INFO - Return code: 0 21:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:09 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:09:09 INFO - Using env: {'DISPLAY': ':0', 21:09:09 INFO - 'HOME': '/home/cltbld', 21:09:09 INFO - 'LANG': 'en_US.UTF-8', 21:09:09 INFO - 'LANGUAGE': 'en_US:en', 21:09:09 INFO - 'LOGNAME': 'cltbld', 21:09:09 INFO - 'MAIL': '/var/mail/cltbld', 21:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:09 INFO - 'MOZ_NO_REMOTE': '1', 21:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:09 INFO - 'NO_EM_RESTART': '1', 21:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:09 INFO - 'PWD': '/builds/slave/test', 21:09:09 INFO - 'SHELL': '/bin/bash', 21:09:09 INFO - 'SHLVL': '1', 21:09:09 INFO - 'TERM': 'linux', 21:09:09 INFO - 'TMOUT': '86400', 21:09:09 INFO - 'USER': 'cltbld', 21:09:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:09 INFO - '_': '/tools/buildbot/bin/python'} 21:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:09 INFO - Running setup.py (path:/tmp/pip-Z9Vkp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:09 INFO - Running setup.py (path:/tmp/pip-cslp5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:09 INFO - Running setup.py (path:/tmp/pip-WYSEFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:09 INFO - Running setup.py (path:/tmp/pip-IYkGCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:10 INFO - Running setup.py (path:/tmp/pip-Hn77VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:10 INFO - Running setup.py (path:/tmp/pip-XGHQqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:10 INFO - Running setup.py (path:/tmp/pip-9z9ieB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:10 INFO - Running setup.py (path:/tmp/pip-dGFspd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:10 INFO - Running setup.py (path:/tmp/pip-tC_O4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:10 INFO - Running setup.py (path:/tmp/pip-VY6q_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:10 INFO - Running setup.py (path:/tmp/pip-ivUXFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:10 INFO - Running setup.py (path:/tmp/pip-H6seR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:10 INFO - Running setup.py (path:/tmp/pip-ISsnZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:10 INFO - Running setup.py (path:/tmp/pip-VVWAD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:10 INFO - Running setup.py (path:/tmp/pip-RCvovz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:10 INFO - Running setup.py (path:/tmp/pip-UR7lIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:10 INFO - Running setup.py (path:/tmp/pip-Hi8wor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:10 INFO - Running setup.py install for manifestparser 21:09:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Running setup.py install for mozcrash 21:09:11 INFO - Running setup.py install for mozdebug 21:09:11 INFO - Running setup.py install for mozdevice 21:09:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Running setup.py install for mozfile 21:09:11 INFO - Running setup.py install for mozhttpd 21:09:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Running setup.py install for mozinfo 21:09:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Running setup.py install for mozInstall 21:09:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:11 INFO - Running setup.py install for mozleak 21:09:11 INFO - Running setup.py install for mozlog 21:09:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Running setup.py install for moznetwork 21:09:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Running setup.py install for mozprocess 21:09:12 INFO - Running setup.py install for mozprofile 21:09:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Running setup.py install for mozrunner 21:09:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Running setup.py install for mozscreenshot 21:09:12 INFO - Running setup.py install for moztest 21:09:12 INFO - Running setup.py install for mozversion 21:09:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:12 INFO - Cleaning up... 21:09:12 INFO - Return code: 0 21:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:12 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:09:12 INFO - Using env: {'DISPLAY': ':0', 21:09:12 INFO - 'HOME': '/home/cltbld', 21:09:12 INFO - 'LANG': 'en_US.UTF-8', 21:09:12 INFO - 'LANGUAGE': 'en_US:en', 21:09:12 INFO - 'LOGNAME': 'cltbld', 21:09:12 INFO - 'MAIL': '/var/mail/cltbld', 21:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:12 INFO - 'MOZ_NO_REMOTE': '1', 21:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:12 INFO - 'NO_EM_RESTART': '1', 21:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:12 INFO - 'PWD': '/builds/slave/test', 21:09:12 INFO - 'SHELL': '/bin/bash', 21:09:12 INFO - 'SHLVL': '1', 21:09:12 INFO - 'TERM': 'linux', 21:09:12 INFO - 'TMOUT': '86400', 21:09:12 INFO - 'USER': 'cltbld', 21:09:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:12 INFO - '_': '/tools/buildbot/bin/python'} 21:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:12 INFO - Running setup.py (path:/tmp/pip-2nOSDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:13 INFO - Running setup.py (path:/tmp/pip-2hY1ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:13 INFO - Running setup.py (path:/tmp/pip-mF5KqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:13 INFO - Running setup.py (path:/tmp/pip-wKqmGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:13 INFO - Running setup.py (path:/tmp/pip-VrSzPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:13 INFO - Running setup.py (path:/tmp/pip-BAbYzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:13 INFO - Running setup.py (path:/tmp/pip-IuSAwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:13 INFO - Running setup.py (path:/tmp/pip-fnDO4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:13 INFO - Running setup.py (path:/tmp/pip-UIW1uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:13 INFO - Running setup.py (path:/tmp/pip-hskTce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:13 INFO - Running setup.py (path:/tmp/pip-4TTNPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:13 INFO - Running setup.py (path:/tmp/pip-9qnL2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:13 INFO - Running setup.py (path:/tmp/pip-iLvB2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:13 INFO - Running setup.py (path:/tmp/pip-rJczo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:13 INFO - Running setup.py (path:/tmp/pip-mRa7cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:14 INFO - Running setup.py (path:/tmp/pip-Em3XEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:14 INFO - Running setup.py (path:/tmp/pip-6q6Xov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:16 INFO - Downloading blessings-1.6.tar.gz 21:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:16 INFO - Installing collected packages: blessings 21:09:16 INFO - Running setup.py install for blessings 21:09:16 INFO - Successfully installed blessings 21:09:16 INFO - Cleaning up... 21:09:16 INFO - Return code: 0 21:09:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:16 INFO - Reading from file tmpfile_stdout 21:09:16 INFO - Current package versions: 21:09:16 INFO - argparse == 1.2.1 21:09:16 INFO - blessings == 1.6 21:09:16 INFO - blobuploader == 1.2.4 21:09:16 INFO - docopt == 0.6.1 21:09:16 INFO - manifestparser == 1.1 21:09:16 INFO - mozInstall == 1.12 21:09:16 INFO - mozcrash == 0.17 21:09:16 INFO - mozdebug == 0.1 21:09:16 INFO - mozdevice == 0.48 21:09:16 INFO - mozfile == 1.2 21:09:16 INFO - mozhttpd == 0.7 21:09:16 INFO - mozinfo == 0.9 21:09:16 INFO - mozleak == 0.1 21:09:16 INFO - mozlog == 3.1 21:09:16 INFO - moznetwork == 0.27 21:09:16 INFO - mozprocess == 0.22 21:09:16 INFO - mozprofile == 0.28 21:09:16 INFO - mozrunner == 6.11 21:09:16 INFO - mozscreenshot == 0.1 21:09:16 INFO - mozsystemmonitor == 0.0 21:09:16 INFO - moztest == 0.7 21:09:16 INFO - mozversion == 1.4 21:09:16 INFO - psutil == 3.1.1 21:09:16 INFO - requests == 1.2.3 21:09:16 INFO - wsgiref == 0.1.2 21:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:16 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:09:16 INFO - Using env: {'DISPLAY': ':0', 21:09:16 INFO - 'HOME': '/home/cltbld', 21:09:16 INFO - 'LANG': 'en_US.UTF-8', 21:09:16 INFO - 'LANGUAGE': 'en_US:en', 21:09:16 INFO - 'LOGNAME': 'cltbld', 21:09:16 INFO - 'MAIL': '/var/mail/cltbld', 21:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:16 INFO - 'MOZ_NO_REMOTE': '1', 21:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:16 INFO - 'NO_EM_RESTART': '1', 21:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:16 INFO - 'PWD': '/builds/slave/test', 21:09:16 INFO - 'SHELL': '/bin/bash', 21:09:16 INFO - 'SHLVL': '1', 21:09:16 INFO - 'TERM': 'linux', 21:09:16 INFO - 'TMOUT': '86400', 21:09:16 INFO - 'USER': 'cltbld', 21:09:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:16 INFO - '_': '/tools/buildbot/bin/python'} 21:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:09:16 INFO - Cleaning up... 21:09:16 INFO - Return code: 0 21:09:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:16 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:09:16 INFO - Using env: {'DISPLAY': ':0', 21:09:16 INFO - 'HOME': '/home/cltbld', 21:09:16 INFO - 'LANG': 'en_US.UTF-8', 21:09:16 INFO - 'LANGUAGE': 'en_US:en', 21:09:16 INFO - 'LOGNAME': 'cltbld', 21:09:16 INFO - 'MAIL': '/var/mail/cltbld', 21:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:16 INFO - 'MOZ_NO_REMOTE': '1', 21:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:16 INFO - 'NO_EM_RESTART': '1', 21:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:16 INFO - 'PWD': '/builds/slave/test', 21:09:16 INFO - 'SHELL': '/bin/bash', 21:09:16 INFO - 'SHLVL': '1', 21:09:16 INFO - 'TERM': 'linux', 21:09:16 INFO - 'TMOUT': '86400', 21:09:16 INFO - 'USER': 'cltbld', 21:09:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:16 INFO - '_': '/tools/buildbot/bin/python'} 21:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:16 INFO - Downloading/unpacking jsonschema 21:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:09:18 INFO - Downloading/unpacking functools32 (from jsonschema) 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09: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 21:09:19 INFO - Downloading functools32-3.2.3-2.tar.gz 21:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:09:19 INFO - warning: no files found matching '*.txt' 21:09:19 INFO - no previously-included directories found matching 'build' 21:09:19 INFO - no previously-included directories found matching 'dist' 21:09:19 INFO - no previously-included directories found matching '.git*' 21:09:19 INFO - Installing collected packages: jsonschema, functools32 21:09:19 INFO - Running setup.py install for functools32 21:09:19 INFO - warning: no files found matching '*.txt' 21:09:19 INFO - no previously-included directories found matching 'build' 21:09:19 INFO - no previously-included directories found matching 'dist' 21:09:19 INFO - no previously-included directories found matching '.git*' 21:09:19 INFO - Successfully installed jsonschema functools32 21:09:19 INFO - Cleaning up... 21:09:19 INFO - Return code: 0 21:09:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:19 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 0x7f36ac41df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23aa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, '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': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:09:19 INFO - Using env: {'DISPLAY': ':0', 21:09:19 INFO - 'HOME': '/home/cltbld', 21:09:19 INFO - 'LANG': 'en_US.UTF-8', 21:09:19 INFO - 'LANGUAGE': 'en_US:en', 21:09:19 INFO - 'LOGNAME': 'cltbld', 21:09:19 INFO - 'MAIL': '/var/mail/cltbld', 21:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:19 INFO - 'MOZ_NO_REMOTE': '1', 21:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:19 INFO - 'NO_EM_RESTART': '1', 21:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:19 INFO - 'PWD': '/builds/slave/test', 21:09:19 INFO - 'SHELL': '/bin/bash', 21:09:19 INFO - 'SHLVL': '1', 21:09:19 INFO - 'TERM': 'linux', 21:09:19 INFO - 'TMOUT': '86400', 21:09:19 INFO - 'USER': 'cltbld', 21:09:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:19 INFO - '_': '/tools/buildbot/bin/python'} 21:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:19 INFO - Downloading/unpacking flake8 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:09:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:09:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:09:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:09:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:09:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:09:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:09:22 INFO - no previously-included directories found matching 'docs/_build' 21:09:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:09:22 INFO - Running setup.py install for pep8 21:09:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:09:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:09:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:09:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:09:22 INFO - no previously-included directories found matching 'docs/_build' 21:09:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:09:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:09:22 INFO - Cleaning up... 21:09:22 INFO - Return code: 0 21:09:22 INFO - Running post-action listener: _resource_record_post_action 21:09:22 INFO - Running post-action listener: _start_resource_monitoring 21:09:23 INFO - Starting resource monitoring. 21:09:23 INFO - ##### 21:09:23 INFO - ##### Running install step. 21:09:23 INFO - ##### 21:09:23 INFO - Running pre-action listener: _resource_record_pre_action 21:09:23 INFO - Running main action method: install 21:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:23 INFO - Reading from file tmpfile_stdout 21:09:23 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:23 INFO - Reading from file tmpfile_stdout 21:09:23 INFO - Output received: 21:09:23 INFO - Usage: mozinstall [options] installer 21:09:23 INFO - Options: 21:09:23 INFO - -h, --help show this help message and exit 21:09:23 INFO - -d DEST, --destination=DEST 21:09:23 INFO - Directory to install application into. [default: 21:09:23 INFO - "/builds/slave/test"] 21:09:23 INFO - --app=APP Application being installed. [default: firefox] 21:09:23 INFO - mkdir: /builds/slave/test/build/application 21:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:09:39 INFO - Reading from file tmpfile_stdout 21:09:39 INFO - Output received: 21:09:39 INFO - /builds/slave/test/build/application/firefox/firefox 21:09:39 INFO - Running post-action listener: _resource_record_post_action 21:09:39 INFO - ##### 21:09:39 INFO - ##### Running run-tests step. 21:09:39 INFO - ##### 21:09:39 INFO - Running pre-action listener: _resource_record_pre_action 21:09:39 INFO - Running main action method: run_tests 21:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:39 INFO - Python 2.7.3 21:09:39 INFO - Return code: 0 21:09:39 INFO - grabbing minidump binary from tooltool 21:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:39 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 0x2439410>, '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 0x243a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:09:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:09:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:39 INFO - Return code: 0 21:09:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:09:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:09:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:09:40 INFO - Return code: 0 21:09:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:09:40 INFO - Using env: {'DISPLAY': ':0', 21:09:40 INFO - 'HOME': '/home/cltbld', 21:09:40 INFO - 'LANG': 'en_US.UTF-8', 21:09:40 INFO - 'LANGUAGE': 'en_US:en', 21:09:40 INFO - 'LOGNAME': 'cltbld', 21:09:40 INFO - 'MAIL': '/var/mail/cltbld', 21:09:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:40 INFO - 'MOZ_NO_REMOTE': '1', 21:09:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:40 INFO - 'NO_EM_RESTART': '1', 21:09:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:40 INFO - 'PWD': '/builds/slave/test', 21:09:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:40 INFO - 'SHELL': '/bin/bash', 21:09:40 INFO - 'SHLVL': '1', 21:09:40 INFO - 'TERM': 'linux', 21:09:40 INFO - 'TMOUT': '86400', 21:09:40 INFO - 'USER': 'cltbld', 21:09:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461463055.639292-1051849193', 21:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:40 INFO - '_': '/tools/buildbot/bin/python'} 21:09:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:09:40 INFO - mozversion application_buildid: 20160423200647 21:09:40 INFO - mozversion application_changeset: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 21:09:40 INFO - mozversion application_display_name: Nightly 21:09:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:40 INFO - mozversion application_name: Firefox 21:09:40 INFO - mozversion application_remotingname: firefox 21:09:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:09:40 INFO - mozversion application_vendor: Mozilla 21:09:40 INFO - mozversion application_version: 48.0a1 21:09:40 INFO - mozversion platform_buildid: 20160423200647 21:09:40 INFO - mozversion platform_changeset: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 21:09:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:09:40 INFO - mozversion platform_version: 48.0a1 21:09:40 INFO - using testdate: 1461470980 21:09:40 INFO - actual date: 1461470980 21:09:40 INFO - starting webserver on 'localhost:50484' 21:09:40 INFO - SUITE-START | Running 2 tests 21:09:40 INFO - TEST-START | dromaeo_css 21:09:40 INFO - operating with platform_type : linux_ 21:09:40 INFO - Initialising browser for dromaeo_css test... 21:09:40 INFO - TEST-INFO | started process 4991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQfW1YX/profile http://localhost:50484/getInfo.html) 21:09:44 INFO - PROCESS | 4991 | 21:09:44 INFO - PROCESS | 4991 | (process:5059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:09:45 INFO - PROCESS | 4991 | __metrics Screen width/height:1600/1200 21:09:45 INFO - PROCESS | 4991 | colorDepth:24 21:09:45 INFO - PROCESS | 4991 | Browser inner width/height: 1024/697 21:09:45 INFO - PROCESS | 4991 | __metrics 21:09:46 ERROR - PROCESS | 4991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:09:46 INFO - TEST-INFO | 4991: exit 0 21:09:46 INFO - Browser initialized. 21:09:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:09:46 INFO - TEST-INFO | started process 5110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQfW1YX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:09:48 INFO - PROCESS | 5110 | 21:09:48 INFO - PROCESS | 5110 | (process:5169): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:09:58 INFO - PROCESS | 5110 | RSS: Main: 165502976 21:09:58 INFO - PROCESS | 5110 | 21:10:48 INFO - PROCESS | 5110 | 1461471048516 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] 21:13:00 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50484/tests/dromaeo/cssquery-ext.html) 21:13:01 INFO - PROCESS | 5110 | RSS: Main: 169418752 21:13:01 INFO - PROCESS | 5110 | 21:16:03 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-ext.html (next: http://localhost:50484/tests/dromaeo/cssquery-jquery.html) 21:16:03 INFO - PROCESS | 5110 | RSS: Main: 166985728 21:16:03 INFO - PROCESS | 5110 | 21:19:05 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50484/tests/dromaeo/cssquery-mootools.html) 21:19:06 INFO - PROCESS | 5110 | RSS: Main: 167854080 21:19:06 INFO - PROCESS | 5110 | 21:22:08 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50484/tests/dromaeo/cssquery-prototype.html) 21:22:08 INFO - PROCESS | 5110 | RSS: Main: 165859328 21:22:08 INFO - PROCESS | 5110 | 21:25:11 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50484/tests/dromaeo/cssquery-yui.html) 21:25:12 INFO - PROCESS | 5110 | RSS: Main: 167264256 21:25:12 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | Cycle 1(1): loaded http://localhost:50484/tests/dromaeo/cssquery-yui.html (next: http://localhost:50484/tests/dromaeo/cssquery-dojo.html) 21:28:14 INFO - PROCESS | 5110 | RSS: Main: 169271296 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | __start_tp_report 21:28:14 INFO - PROCESS | 5110 | _x_x_mozilla_page_load 21:28:14 INFO - PROCESS | 5110 | _x_x_mozilla_page_load_details 21:28:14 INFO - PROCESS | 5110 | |i|pagename|runs| 21:28:14 INFO - PROCESS | 5110 | |0;dojo.html;2637.788976881849;2681.6245725598415;2702.1083042595947;2707.56678931371;2708.878100485478;4699.2951057341415;4718.598919091873;4726.314684370765;4729.787159577819;4776.641751868607;4668.719876807394;4754.524547545244;4787.545183207599;4834.129856625806;4854.223324268118;4408.096340250249;4451.532589078149;4458.4872739634875;4485.887852803673;4530.093981203756;4415.028693687384;4476.6418686505;4501.954980450187;4523.208438523246;4525.456945166585;4321.092570560186;4402.7798610069685;4419.160359531678;4457.799399027052;4467.977660111678;4390.275604525282;4416.712913660602;4435.135148646015;4440.866773996785;4479.037007043501;4376.7811609419405;4391.704447188087;4396.1427521633295;4411.42651455312;4450.376947227391;4617.492075871652;4683.227267500858;4685.133250348662;4711.222648263067;4730.455997560291;5078.974605126988;5091.592672586185;5112.565431938289;5115.309433226504;5137.48625137487;5132.3327967364;5140.485951404867;5144.485551444863;5153.716545589991;5189.844304670828;4768.976155119202;4769.904601907942;4772.570468657837;4789.521047895218;4820.927686084711;5152.330197074356;5208.791648334024;5210.348706411699;5241.816536421207;5250.028744682169;4968.453470118284;5012.064429503631;5038.622103342191;5068.949310506848;5160.948390516121;5140.922886156711;5174.741262936838;5196.142636464941;5197.792088316501;5225.111731005738;4999.825006124768;5106.795728170831;5196.506331898464;5199.636025478256;5223.268742376071;4928.137575924199;4997.175466048134;5014.648974571818;5040.546350828443;5053.090443720165;4372.672049596293;4382.780860956939;4385.693001489929;4416.984093658477;4431.290993441034;3791.184895247535;3803.144292534213;3816.694664426839;3842.8462861485227;3862.1503269280715;4269.509006464296;4331.913361732748;4372.978135109304;4414.84548040817;4418.447694038246;5150.510701483353;5193.506616871391;5203.19350500673;5215.139501982207;5250.868728281747;4403.097365040159;4441.933370999438;4454.242778727624;4459.554044595515;4494.325851122358;4467.754273514923;4583.9312410313205;4651.813927442932;4667.159911216014;4681.508441613581;4706.152892479249;4729.952700472952;4759.143354196278;4762.357081793983;4793.976030119967;5044.596432285335;5059.241113832954;5061.266116413173;5091.159958606789;5118.692878427306;4686.601638860735;4775.379200703886;4805.327254184347;4811.08589368019;4823.155947709207;5014.974925125351;5029.924551131663;5034.244863270393;5038.924416133687;5081.263216833612;5022.874428139326;5119.257707632298;5120.078385890575;5122.487751224997;5125.8974820502635;4877.195262781602;4879.56083952446;5046.873828154326;5074.238864170404;5093.516115968977;4960.379952505937;4967.081089998362;4976.527229913152;4980.103581355391;4985.775640096132;4813.1336359454235;4847.587955023862;4849.393825771778;4885.828995985124;4955.306257123933;4882.2920676501;5009.699418034929;5016.498350164954;5054.444011158696;5075.695458272516;4921.114199444134;4922.335484709519;4923.5814955729165;4929.16204245272;4935.235038568884 21:28:14 INFO - PROCESS | 5110 | |1;ext.html;573.2433188191588;599.2150283129101;604.0425924909019;618.7617767159644;645.9386358295964;34137.82931085344;35649.82175089124;35726.642733572655;35814.283714325764;35835.10412239695;37718;38766.22467550647;38794.224115517674;38797.22405551887;38854.41718374227;7592.468527203098;7814.492058016211;7818.569978651172;7820.843583128334;7823.491473054261;7622.961885190566;7729.690812367527;7752.372001879584;7759.5344279343135;7765.262300081483;7861.489003214772;7912;7979.880301795478;7994.280514753671;8007.439479236456;7884;7942.761717148466;7958.801029974239;7968.641411136484;7980.122186559473;7748.961255193744;7863.606819658994;7866.646000929914;7895.210478952116;7896.5262084274555;37949.81025094857;37987.430188547194;38176.236475270336;38178.80910595429;38268;3225.6774322567558;3255.153660048381;3276.3774882772195;3360;3488.8081155536433;28850.278743031384;29026.85486572575;29078.27304317388;29228.41543169146;29414.264643384086;3496.8950931472095;3522.4892390603477;3559.056849934769;3624.039629498185;3743.700503959704;230920;231065;232687.8365608178;232963;233951;51909;52950;52963.205551915984;52989.205161922604;53078;55702;55799.16301255403;66187.66906165438;68599.3140068603;68952.3104768956;14539.854601454063;14594.781078283835;14652.12087274767;14666.706665866623;14830.629234269014;10921.344719316867;10977.560897564168;11008.669739907815;11014.834777478345;11021.063209627111;18753.906230469034;18776.530586735167;18866;18970.14634341458;19096.61806763857;7080.36276735086;7091.60996145217;7174;7263.709451621981;7340.559566426032;845.1548451548451;860.8421672850006;872.0799556467987;890.1587999340561;918.8529835226332;26106.477870442486;26379;26437.471250575265;26556.8672156638;26578.601320979815;1000.9899901000897;1004.5077911823154;1013.4679293371039;1043.014351437899;1104.812181929074;14333.140011599337;14358.138511689333;14429.639259018608;14437.35031923566;14483.058601190889;375756;381727;382589;385644;385859;49303.50696493061;50544;50862;50901;51004.74497627488;1256.39065053449;1273.808928660727;1275.1775105057372;1278.0606254403006;1284.9550265740654;26808.463830722885;27436.83031146857;27899.16302510928;28186.71813281923;28408.147755567366;41986.1602767949;47803.28295075507;49706;49755;49819.750901245265;244672;247363;247675;247675;247889;38285.2342953145;38454;39275.41086883642;39298.214035718556;39396;42370.15259694851;42773.14453710971;42785.358219626105;43585.782071089445;43676;36435.45346819747;36960.81519592492;37074.443883341235;37558.62441375551;38130.23739525139;35936.82031589825;35949.46075808813;36395.45406818847;36728.63271367252;37429.812850935574;35593.288134237686;36563.63436365602;37119.814400927826;37378.25243495169;37529.061773455884;31640.841795790875;33180.33639327248;33232;33446.66553334533;33688.831555842065;25516.74483255218;25878.741212587633;26026.479470410864;26048.47903041891;26322.4735505285 21:28:14 INFO - PROCESS | 5110 | |2;jquery.html;380.1750202061526;384.63843986652546;388.4057392189949;390.0891418537714;403.58229232744117;15299.54101376959;16791.83208167918;17468;17755.91122044391;17762.200700968457;16525.421610243644;17134.485965421056;17180;17515.5621109472;17516.64966700665;4363.520012798597;5054.9494505054845;5093.414257360396;5108.5913126949945;5115.897682046357;3618.1678214010794;5642.7178641067785;6004.549658775588;6008.549358798107;6020.879582408349;5108.6168537359845;5891.204687367193;5920.615160014607;5960.821175364725;5979.491743201833;5320.201969704536;5369.731513424314;5374.086405311087;5398.028354896137;5407.270018547485;5010.0981823271795;5251.448597897204;5256.26412302278;5279.788808447657;5282.260483532308;12529.43617537213;12553.184043037174;13389;18772.155253013647;19144.80855191444;1817.318505560415;1864.049334839228;1977.831884289837;1987.3739771971927;2008.829249513793;8498.872516912252;9289.396189247676;10509.789804203872;13193.34033298341;13507.324633768272;1702.361614394602;1726.231826837058;1776.3693888669595;1806.223323970692;1847.5381154711322;70301.64849175721;71714.28285717129;71971.2802871975;72209.63895180543;72615.99999999948;9718.465484398284;9972.950135249423;10060;10127.240456965757;10294.227932905062;13942.302884855919;13991.58025259244;14039.85960140406;14136.363863626162;14136.363863626162;7220.675069621774;7240.710371585077;7279.41764658826;7331.706731730777;7427.145878224073;6824.146981627297;6835.248122706498;6922.203946546111;7034.19106802714;7040.92959070413;4355.128974205171;4390.341448782644;4407.625351845065;4417.712848664826;4423.5576442355505;1656.2546853915785;1777.6355847051323;1868.4394681595468;1876.6903460929068;1897.6655227545436;914.9817003659889;922.4649703172144;966.4346357380871;969.471637957315;985.5170966226641;15974.520764377086;16171.191440428167;16263.024218546925;16650;16740.246688898784;885.3138817416553;894.1952242981368;899.8515244984504;937.1659223291276;946.5125460387906;9012.324075694349;9154.86267705985;9222.907770922338;9260.907390926139;9418.293627977791;254621;263473;394781;396966;399192;83561.58219208865;83686.58156709178;85794.42336248123;86381.56809215914;87491.12508874957;935.4340623922565;976.1800087926176;1006.06938581813;1008.5864795433837;1011.1354791653177;15385.538433847003;15446.2276886153;15455.227238637799;15471.149086799884;15552.766708499608;35532.467012995345;35712.8214358937;36328;36718.63281367259;37265.25469490649;48537.75731121463;51314;51344.48655513547;51523.22715159201;52087;7258.854822903407;7403.629818509161;7450.888236676563;7642.273983971514;7643.235676432312;5217;5500.614956952975;10313.432761198206;10785.298955567863;10941.617043403443;8396.118407567117;9303.023182565734;9348.906510935076;9552.188064014637;9565.426074435556;9177.21993630549;9386.67146649864;9398.483083430478;9457.290703197425;9750.073742994404;9561;9591.136797688241;9611.231101511723;9642.71071867845;9836.311458198144;7174.461915356264;7287.27127287267;7310.853782924418;7361.705531778883;7520.8495830082;8764.605592748214;8928.15182557656;8991.41555798871;9163.175314221751;10021.549030293509 21:28:14 INFO - PROCESS | 5110 | |3;mootools.html;1263.3051821498177;1348.5414958913973;1380.3581334679375;1536.1474381718142;1553.277725857476;6995.370416662499;7670;7736.303732664059;7870.921290787091;7929;7789.844203115934;7880.527168369902;7886.684532618703;7926.326262267714;7932.167122452146;2219.622664147099;2243.955120897581;2250.639897616382;2252.2905284835224;2255.030336955109;2150.2689085710854;2200.7249093863265;2227.4988127671227;2231.3306008197474;2234.2850287907877;2163.3834357208198;2202.878841663708;2203.3389983005113;2208.1608988584394;2228.520868013377;2174.9891250543806;2177.4556360909774;2190.3428971308545;2192.71494705688;2193.8573992690503;2156.0728886578763;2166.328438184168;2172.435166856613;2175.5213852952324;2176.62997290461;7945.4438189326775;7983.241592048804;8049.114597394282;8053.758387248392;8121.4721043132;4769.618430525549;4933.235348520985;4945.258211268302;4948.752562371867;4956.281339205831;2894.2266107517903;3037.104054303986;3083.784135110543;3109.4247564200696;3110.9844450777828;939.3893968920188;957.2916042128844;957.9712608621752;979.2264111352094;985.3250523391499;10846.728831779268;10884.564617415293;10995.285306455055;10996.505157267942;11060.281081729743;4326.459192600925;4387.473503179639;4514.7291162530355;4542.84100056503;4548.522405147478;9262.490563019099;9263.16631503168;9275.0261222572;9327.580258888367;9361.859572106288;4946.282788995575;4949.529794669501;4957.628177886673;4974.154393752999;4977.701337919736;3892.279928213233;4374.343848422762;4471.821127154877;4477.395551600557;4500.887477813016;3708.0915175781565;3744.925101497955;3803.904902377463;3866.3040652682225;3878.3212937735784;1221.7190046289404;1264.8988080953502;1265.487477571585;1276.9553065642658;1280.8719128087116;813.1380736419414;836.9665213391396;844.9408541402042;884.951327676984;928.7074571509953;5295.973520132375;5339.652922560022;5466.781328746885;5516.117421212587;5741.282339707536;855.7774978505508;861.7845538615346;863.935204859638;869.1352104655908;870.4907629037084;3636.2182130841998;3672.5225720656144;3737.4767532545466;3751.0622344413896;3771.377722675728;8826.911730882737;9001.819963600692;9106.180443760093;9155.54222288883;9170.266378689688;9175.908240917639;9182.908170918205;9186.081391860895;9263.305252106118;9277.350585458953;7202.92797072033;7494.138174110047;7512.887306690294;7555;7606.239376062349;5181.896362072662;5426.620136590401;5438.972805135949;5455.236266922713;5622.437756224344;8875.778105547413;8907;9083.545822708706;9188.954055229948;9223.44659320443;8817.911820881709;9049.049849765679;9211.677591284273;9213.355065145644;9230.907690923004;6074.696265186812;6191.288001879841;6399.936000639934;6439.452646525097;6637.435817955527;7513.323800857949;7534.284242996907;7561.054868141482;7601.847963040819;7633.274838890296;6619.735210591522;6866.416354609714;6968.338007889242;6988.580685158907;7149.392301654418;6762.560433571802;6794.150731158606;6902;6935.306469353226;6952.652367381712;6180.783672571439;6359.586626869239;6660.933390666031;6742.696578653874;6753.696083676148;4533.727976321431;4544.454665440168;4573.245414506702;4605.631549476101;4647.814087436464;4663.114008338541;4680.92978605328;4722.693024953367;4747.9791844753545;4755.714657120584 21:28:14 INFO - PROCESS | 5110 | |4;prototype.html;320.88287774962146;321.46797050880787;329.74444805275914;331.7362696656157;333.8864785972769;5420.891582168354;5449.555867695064;5461.37194222664;5491.1763235514645;5506.091494903336;5348.171033489805;5358.919616205751;5369.643972517177;5374.113271310239;5377.919331210025;3927.4894263745673;4078.714489985702;4212.705110642256;4216.346466297713;4226.070264541811;4213.1363070570615;4214.831406743727;4216.810243539048;4216.852410165645;4230.153969206156;4177.394277829713;4202.747835129902;4204.579542045802;4207.495100587934;4219.177260434217;4115.362118871565;4185.476815398075;4200.1389715108635;4202.453681021479;4223.303154979425;3707.3326801175776;3708.5364329458816;3722.5346831646043;3724.515812944327;3733.178700685845;5132.692038477703;5148.768305426265;5161.612879034087;5162.277281180638;5200.29795977542;4822.493638167977;4902.975485122587;4913.94350214702;4922.975385123087;4923.901521969577;5735;5738.942610573882;5747.568932330092;5751.166080918285;5762.9135562966585;4062.2687916175078;4105.938410923838;4107.260693075275;4119.526254480743;4133.793310334471;5685.260916080924;5970.164177015265;6016.639001659914;6021.2473440819895;6026.728797204137;4207.600277973587;4217.304144816132;4242.8727138185905;4243.872683819491;4244.04508985482;4306.569343065668;4308.526062133163;4310.073334233155;4318.157959197989;4327.394164816928;4489.191945449785;4736.455307639666;4813.181759100961;4841.298011788342;4883.194272944925;5729.770809167587;5733.684647344436;5745.6552606843725;5747.85630359236;5772.6536407815665;1431.9546730886511;1453.4331610671848;1459.496473716566;1460.6056364781662;1462.5246794791735;875.899271583776;936.3539157980971;938.442185971298;955.9904400956041;957.9904200958041;4826.066755594179;4852.4662287148385;4873.342098816685;4904.779284932187;4905.484924082992;5796.478316951495;5825.88348233033;5831.795887144014;5840.678762668009;5840.795572154954;4706;4873.390826146731;4889.364382630307;4893.730844803499;4949.57928576075;3167.7940933839227;3199.104250809777;3205.4550726376574;3208.743300535998;3209.534617480452;5509.917351239735;5565.638233514808;5574.303212098488;5581.274434323594;5582.24639673647;5948.494377977834;6074.42292982166;6106.816795496142;6132.6627035513475;6132.877342453126;5536.307961504812;5555.111182210827;5558.166275058693;5571.331440227199;5573.6098473106495;5641.887162256814;5960.672163031075;5967.224260846062;5973.611715238496;5997.940020599738;5847.415258474119;5895.67573783446;5909.320428150818;5911.970440147772;5919.644821310735;5569.972150139223;5588.469095435927;5591.6365436246515;5603.607747457639;5622.943770562406;3995.5405128410603;4099.733517321364;4119.402686610485;4146.1500392420085;4146.79266036703;5902.350741418355;5960.672163031075;5993.40395762539;6007.519398448201;6016.699165041818;5575.776968921197;5726.590525295583;5763.406467089911;5775.653460792366;5791.739371728367;5713.314402271754;5722.971385143214;5735.7705691773535;5779.682117483579;5782.710864456844;5393.83818485446;5660.405657406078;5666.631668941505;5698.6580805151825;5710.885782284248;5581.804636837691;5764.682942438206;5790.189373487631;5800.912986305293;5804.65172089676;5642.633228840113;5657.943420565906;5685.175649530877;5692.857678558069;5695.946249943774 21:28:14 INFO - PROCESS | 5110 | |5;yui.html;651.2022772104172;763.4312437234258;778.540661010004;779.7465823607329;798.6046906781144;14088.788668169973;14524;14605.342759575818;14607.269636518171;14610.123392596424;14026.088304260216;14040.227787471686;14055.78916316256;14105.294735263247;14133.929330353334;650.6746626686656;821.6343727041469;827.7682248970298;828.0229329391346;828.3166387730147;811.5333683132222;834.3408707121367;835.0980940584185;835.9205875441824;836.4437648963432;855.3371137368558;865.523961820999;868.179570306061;869.3393021303791;869.5391442535466;862.2326129744532;865.809521905183;867.0116067682847;867.0505796153266;867.0982178534317;621.909823075656;628.2272804450506;628.9905651415232;629.2354788931425;631.2803404119308;12923.67690807728;12924.224546527144;12924.935375323157;12945.223286602833;12963.546275880299;12247.69380765479;12257.387130643432;12296;12314.50741970329;12490.75018499634;9950.850737238947;9957.203423726085;9989.500524973722;10014;10036.447995360253;3211.14904550292;3245.107595411257;3278.1149089745873;3280.5735254417013;3369.5114208439886;43883.341749873776;43912;44071.77964110191;44215.33676994847;44415.555844441464;9694.46680432583;9868.210543156674;9911.504424778732;9987.151092157103;10022.098011179029;16744.581385465463;16834;16895.915520422564;16907.32370705158;16941.06824124685;6702.128723265944;6713.56361836479;6833.180018397725;6878.209005964378;6931.965340173267;3817.3319669057805;3867.61323867611;3911.6870650347905;3943.9942814582096;3953;2868.6127372804403;2927.370615317717;2929.956050659242;2930.3406733484794;2932.3841993181245;520.1625383133153;522.3027258609799;522.5662699959025;529.4440837121008;533.1017235957424;585.7247093865876;613.1936503497975;614.7110857896781;618.2025187508065;626.6647343671114;7758;7844.176361482077;7934.246246606564;8057.879131813028;8487.533185674847;481.38863643172976;519.2652396858479;520.2274622186051;550.9284441760736;580.3992867382324;3668.6514781095752;3914.72596918213;3917.941230881539;3987.980060099681;3997.480327557399;51063.489365106616;51241.7437912808;52031.47968520342;52061.47938520642;52125.73937130366;45183.322250166275;46474;47121.5287847124;47516;48199.5180048195;41533;42098.78950605227;42173;42346.94132646647;43635;7172.49792514519;7389.852202956018;7486.588237646982;7544.735934242275;7580.583067931317;27933.441331173668;27960.44079118447;28053.57919631248;28550.85724571364;28652.14043578696;34751;35819.64180358163;37990.43014354732;38184.23631527298;38234.80882595569;9727.416355018722;9752.073553012453;9795.118439340493;9806.264530160124;10086.646967356108;10493.580256789643;10574.365538067434;10784.568617255221;10973.780524389627;10996.945015274872;9796.9020309796;9913.256505762241;9942.30403871722;10134.037266459969;10198.694039178836;9983.301168918106;10209;10304.896951030394;10359.792804144026;10714.571417143226;9554.85667714971;9778;10036.49817509107;10123.544440500047;10289.639862604772;8601.698940537051;8634.697785577475;8810.163034511712;8827.955860220658;9254.12085851843;7931.960340198262;8208.384371172067;8217.178282171735;8241.217084377215;8455 21:28:14 INFO - PROCESS | 5110 | __end_tp_report 21:28:14 INFO - PROCESS | 5110 | __start_cc_report 21:28:14 INFO - PROCESS | 5110 | _x_x_mozilla_cycle_collect,387 21:28:14 INFO - PROCESS | 5110 | __end_cc_report 21:28:14 INFO - PROCESS | 5110 | __startTimestamp1461472094823__endTimestamp 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | ------- Summary: start ------- 21:28:14 INFO - PROCESS | 5110 | Number of tests: 6 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | [#0] dojo.html Cycles:165 Average:4730.34 Median:4820.93 stddev:487.17 (10.1%) stddev-sans-first:460.18 21:28:14 INFO - PROCESS | 5110 | Values: 2637.8 2681.6 2702.1 2707.6 2708.9 4699.3 4718.6 4726.3 4729.8 4776.6 4668.7 4754.5 4787.5 4834.1 4854.2 4408.1 4451.5 4458.5 4485.9 4530.1 4415.0 4476.6 4502.0 4523.2 4525.5 4321.1 4402.8 4419.2 4457.8 4468.0 4390.3 4416.7 4435.1 4440.9 4479.0 4376.8 4391.7 4396.1 4411.4 4450.4 4617.5 4683.2 4685.1 4711.2 4730.5 5079.0 5091.6 5112.6 5115.3 5137.5 5132.3 5140.5 5144.5 5153.7 5189.8 4769.0 4769.9 4772.6 4789.5 4820.9 5152.3 5208.8 5210.3 5241.8 5250.0 4968.5 5012.1 5038.6 5068.9 5160.9 5140.9 5174.7 5196.1 5197.8 5225.1 4999.8 5106.8 5196.5 5199.6 5223.3 4928.1 4997.2 5014.6 5040.5 5053.1 4372.7 4382.8 4385.7 4417.0 4431.3 3791.2 3803.1 3816.7 3842.8 3862.2 4269.5 4331.9 4373.0 4414.8 4418.4 5150.5 5193.5 5203.2 5215.1 5250.9 4403.1 4441.9 4454.2 4459.6 4494.3 4467.8 4583.9 4651.8 4667.2 4681.5 4706.2 4730.0 4759.1 4762.4 4794.0 5044.6 5059.2 5061.3 5091.2 5118.7 4686.6 4775.4 4805.3 4811.1 4823.2 5015.0 5029.9 5034.2 5038.9 5081.3 5022.9 5119.3 5120.1 5122.5 5125.9 4877.2 4879.6 5046.9 5074.2 5093.5 4960.4 4967.1 4976.5 4980.1 4985.8 4813.1 4847.6 4849.4 4885.8 4955.3 4882.3 5009.7 5016.5 5054.4 5075.7 4921.1 4922.3 4923.6 4929.2 4935.2 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | [#1] ext.html Cycles:180 Average:45524.58 Median:20586.76 stddev:77538.29 (376.6%) stddev-sans-first:77682.35 21:28:14 INFO - PROCESS | 5110 | Values: 573.2 599.2 604.0 618.8 645.9 34137.8 35649.8 35726.6 35814.3 35835.1 37718.0 38766.2 38794.2 38797.2 38854.4 7592.5 7814.5 7818.6 7820.8 7823.5 7623.0 7729.7 7752.4 7759.5 7765.3 7861.5 7912.0 7979.9 7994.3 8007.4 7884.0 7942.8 7958.8 7968.6 7980.1 7749.0 7863.6 7866.6 7895.2 7896.5 37949.8 37987.4 38176.2 38178.8 38268.0 3225.7 3255.2 3276.4 3360.0 3488.8 28850.3 29026.9 29078.3 29228.4 29414.3 3496.9 3522.5 3559.1 3624.0 3743.7 230920.0 231065.0 232687.8 232963.0 233951.0 51909.0 52950.0 52963.2 52989.2 53078.0 55702.0 55799.2 66187.7 68599.3 68952.3 14539.9 14594.8 14652.1 14666.7 14830.6 10921.3 10977.6 11008.7 11014.8 11021.1 18753.9 18776.5 18866.0 18970.1 19096.6 7080.4 7091.6 7174.0 7263.7 7340.6 845.2 860.8 872.1 890.2 918.9 26106.5 26379.0 26437.5 26556.9 26578.6 1001.0 1004.5 1013.5 1043.0 1104.8 14333.1 14358.1 14429.6 14437.4 14483.1 375756.0 381727.0 382589.0 385644.0 385859.0 49303.5 50544.0 50862.0 50901.0 51004.7 1256.4 1273.8 1275.2 1278.1 1285.0 26808.5 27436.8 27899.2 28186.7 28408.1 41986.2 47803.3 49706.0 49755.0 49819.8 244672.0 247363.0 247675.0 247675.0 247889.0 38285.2 38454.0 39275.4 39298.2 39396.0 42370.2 42773.1 42785.4 43585.8 43676.0 36435.5 36960.8 37074.4 37558.6 38130.2 35936.8 35949.5 36395.5 36728.6 37429.8 35593.3 36563.6 37119.8 37378.3 37529.1 31640.8 33180.3 33232.0 33446.7 33688.8 25516.7 25878.7 26026.5 26048.5 26322.5 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | [#2] jquery.html Cycles:180 Average:22967.27 Median:28652.00 stddev:58242.78 (203.3%) stddev-sans-first:58381.48 21:28:14 INFO - PROCESS | 5110 | Values: 380.2 384.6 388.4 390.1 403.6 15299.5 16791.8 17468.0 17755.9 17762.2 16525.4 17134.5 17180.0 17515.6 17516.6 4363.5 5054.9 5093.4 5108.6 5115.9 3618.2 5642.7 6004.5 6008.5 6020.9 5108.6 5891.2 5920.6 5960.8 5979.5 5320.2 5369.7 5374.1 5398.0 5407.3 5010.1 5251.4 5256.3 5279.8 5282.3 12529.4 12553.2 13389.0 18772.2 19144.8 1817.3 1864.0 1977.8 1987.4 2008.8 8498.9 9289.4 10509.8 13193.3 13507.3 1702.4 1726.2 1776.4 1806.2 1847.5 70301.6 71714.3 71971.3 72209.6 72616.0 9718.5 9973.0 10060.0 10127.2 10294.2 13942.3 13991.6 14039.9 14136.4 14136.4 7220.7 7240.7 7279.4 7331.7 7427.1 6824.1 6835.2 6922.2 7034.2 7040.9 4355.1 4390.3 4407.6 4417.7 4423.6 1656.3 1777.6 1868.4 1876.7 1897.7 915.0 922.5 966.4 969.5 985.5 15974.5 16171.2 16263.0 16650.0 16740.2 885.3 894.2 899.9 937.2 946.5 9012.3 9154.9 9222.9 9260.9 9418.3 254621.0 263473.0 394781.0 396966.0 399192.0 83561.6 83686.6 85794.4 86381.6 87491.1 935.4 976.2 1006.1 1008.6 1011.1 15385.5 15446.2 15455.2 15471.1 15552.8 35532.5 35712.8 36328.0 36718.6 37265.3 48537.8 51314.0 51344.5 51523.2 52087.0 7258.9 7403.6 7450.9 7642.3 7643.2 5217.0 5500.6 10313.4 10785.3 10941.6 8396.1 9303.0 9348.9 9552.2 9565.4 9177.2 9386.7 9398.5 9457.3 9750.1 9561.0 9591.1 9611.2 9642.7 9836.3 7174.5 7287.3 7310.9 7361.7 7520.8 8764.6 8928.2 8991.4 9163.2 10021.5 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | [#3] mootools.html Cycles:180 Average:5215.76 Median:5461.01 stddev:2863.74 (52.4%) stddev-sans-first:2856.37 21:28:14 INFO - PROCESS | 5110 | Values: 1263.3 1348.5 1380.4 1536.1 1553.3 6995.4 7670.0 7736.3 7870.9 7929.0 7789.8 7880.5 7886.7 7926.3 7932.2 2219.6 2244.0 2250.6 2252.3 2255.0 2150.3 2200.7 2227.5 2231.3 2234.3 2163.4 2202.9 2203.3 2208.2 2228.5 2175.0 2177.5 2190.3 2192.7 2193.9 2156.1 2166.3 2172.4 2175.5 2176.6 7945.4 7983.2 8049.1 8053.8 8121.5 4769.6 4933.2 4945.3 4948.8 4956.3 2894.2 3037.1 3083.8 3109.4 3111.0 939.4 957.3 958.0 979.2 985.3 10846.7 10884.6 10995.3 10996.5 11060.3 4326.5 4387.5 4514.7 4542.8 4548.5 9262.5 9263.2 9275.0 9327.6 9361.9 4946.3 4949.5 4957.6 4974.2 4977.7 3892.3 4374.3 4471.8 4477.4 4500.9 3708.1 3744.9 3803.9 3866.3 3878.3 1221.7 1264.9 1265.5 1277.0 1280.9 813.1 837.0 844.9 885.0 928.7 5296.0 5339.7 5466.8 5516.1 5741.3 855.8 861.8 863.9 869.1 870.5 3636.2 3672.5 3737.5 3751.1 3771.4 8826.9 9001.8 9106.2 9155.5 9170.3 9175.9 9182.9 9186.1 9263.3 9277.4 7202.9 7494.1 7512.9 7555.0 7606.2 5181.9 5426.6 5439.0 5455.2 5622.4 8875.8 8907.0 9083.5 9189.0 9223.4 8817.9 9049.0 9211.7 9213.4 9230.9 6074.7 6191.3 6399.9 6439.5 6637.4 7513.3 7534.3 7561.1 7601.8 7633.3 6619.7 6866.4 6968.3 6988.6 7149.4 6762.6 6794.2 6902.0 6935.3 6952.7 6180.8 6359.6 6660.9 6742.7 6753.7 4533.7 4544.5 4573.2 4605.6 4647.8 4663.1 4680.9 4722.7 4748.0 4755.7 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | [#4] prototype.html Cycles:180 Average:4746.22 Median:5407.36 stddev:1392.02 (25.7%) stddev-sans-first:1355.72 21:28:14 INFO - PROCESS | 5110 | Values: 320.9 321.5 329.7 331.7 333.9 5420.9 5449.6 5461.4 5491.2 5506.1 5348.2 5358.9 5369.6 5374.1 5377.9 3927.5 4078.7 4212.7 4216.3 4226.1 4213.1 4214.8 4216.8 4216.9 4230.2 4177.4 4202.7 4204.6 4207.5 4219.2 4115.4 4185.5 4200.1 4202.5 4223.3 3707.3 3708.5 3722.5 3724.5 3733.2 5132.7 5148.8 5161.6 5162.3 5200.3 4822.5 4903.0 4913.9 4923.0 4923.9 5735.0 5738.9 5747.6 5751.2 5762.9 4062.3 4105.9 4107.3 4119.5 4133.8 5685.3 5970.2 6016.6 6021.2 6026.7 4207.6 4217.3 4242.9 4243.9 4244.0 4306.6 4308.5 4310.1 4318.2 4327.4 4489.2 4736.5 4813.2 4841.3 4883.2 5729.8 5733.7 5745.7 5747.9 5772.7 1432.0 1453.4 1459.5 1460.6 1462.5 875.9 936.4 938.4 956.0 958.0 4826.1 4852.5 4873.3 4904.8 4905.5 5796.5 5825.9 5831.8 5840.7 5840.8 4706.0 4873.4 4889.4 4893.7 4949.6 3167.8 3199.1 3205.5 3208.7 3209.5 5509.9 5565.6 5574.3 5581.3 5582.2 5948.5 6074.4 6106.8 6132.7 6132.9 5536.3 5555.1 5558.2 5571.3 5573.6 5641.9 5960.7 5967.2 5973.6 5997.9 5847.4 5895.7 5909.3 5912.0 5919.6 5570.0 5588.5 5591.6 5603.6 5622.9 3995.5 4099.7 4119.4 4146.2 4146.8 5902.4 5960.7 5993.4 6007.5 6016.7 5575.8 5726.6 5763.4 5775.7 5791.7 5713.3 5723.0 5735.8 5779.7 5782.7 5393.8 5660.4 5666.6 5698.7 5710.9 5581.8 5764.7 5790.2 5800.9 5804.7 5642.6 5657.9 5685.2 5692.9 5695.9 21:28:14 INFO - PROCESS | 5110 | 21:28:14 INFO - PROCESS | 5110 | [#5] yui.html Cycles:180 Average:12539.28 Median:25880.50 stddev:14195.68 (54.9%) stddev-sans-first:14207.43 21:28:14 INFO - PROCESS | 5110 | Values: 651.2 763.4 778.5 779.7 798.6 14088.8 14524.0 14605.3 14607.3 14610.1 14026.1 14040.2 14055.8 14105.3 14133.9 650.7 821.6 827.8 828.0 828.3 811.5 834.3 835.1 835.9 836.4 855.3 865.5 868.2 869.3 869.5 862.2 865.8 867.0 867.1 867.1 621.9 628.2 629.0 629.2 631.3 12923.7 12924.2 12924.9 12945.2 12963.5 12247.7 12257.4 12296.0 12314.5 12490.8 9950.9 9957.2 9989.5 10014.0 10036.4 3211.1 3245.1 3278.1 3280.6 3369.5 43883.3 43912.0 44071.8 44215.3 44415.6 9694.5 9868.2 9911.5 9987.2 10022.1 16744.6 16834.0 16895.9 16907.3 16941.1 6702.1 6713.6 6833.2 6878.2 6932.0 3817.3 3867.6 3911.7 3944.0 3953.0 2868.6 2927.4 2930.0 2930.3 2932.4 520.2 522.3 522.6 529.4 533.1 585.7 613.2 614.7 618.2 626.7 7758.0 7844.2 7934.2 8057.9 8487.5 481.4 519.3 520.2 550.9 580.4 3668.7 3914.7 3917.9 3988.0 3997.5 51063.5 51241.7 52031.5 52061.5 52125.7 45183.3 46474.0 47121.5 47516.0 48199.5 41533.0 42098.8 42173.0 42346.9 43635.0 7172.5 7389.9 7486.6 7544.7 7580.6 27933.4 27960.4 28053.6 28550.9 28652.1 34751.0 35819.6 37990.4 38184.2 38234.8 9727.4 9752.1 9795.1 9806.3 10086.6 10493.6 10574.4 10784.6 10973.8 10996.9 9796.9 9913.3 9942.3 10134.0 10198.7 9983.3 10209.0 10304.9 10359.8 10714.6 9554.9 9778.0 10036.5 10123.5 10289.6 8601.7 8634.7 8810.2 8828.0 9254.1 7932.0 8208.4 8217.2 8241.2 8455.0 21:28:14 INFO - PROCESS | 5110 | -------- Summary: end -------- 21:28:14 INFO - PROCESS | 5110 | 21:28:15 INFO - TEST-INFO | 5110: exit 0 21:28:15 INFO - TEST-OK | dromaeo_css | took 1115174ms 21:28:15 INFO - TEST-START | kraken 21:28:15 INFO - operating with platform_type : linux_ 21:28:15 INFO - Initialising browser for kraken test... 21:28:15 INFO - TEST-INFO | started process 5344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNY4tX/profile http://localhost:50484/getInfo.html) 21:28:19 INFO - PROCESS | 5344 | 21:28:19 INFO - PROCESS | 5344 | (process:5414): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:28:20 INFO - PROCESS | 5344 | __metrics Screen width/height:1600/1200 21:28:20 INFO - PROCESS | 5344 | colorDepth:24 21:28:20 INFO - PROCESS | 5344 | Browser inner width/height: 1024/697 21:28:20 INFO - PROCESS | 5344 | __metrics 21:28:21 ERROR - PROCESS | 5344 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:28:22 INFO - TEST-INFO | 5344: exit 0 21:28:22 INFO - Browser initialized. 21:28:22 INFO - Running cycle 1/1 for kraken test... 21:28:22 INFO - TEST-INFO | started process 5465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNY4tX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:24 INFO - PROCESS | 5465 | 21:28:24 INFO - PROCESS | 5465 | (process:5524): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:28:34 INFO - PROCESS | 5465 | RSS: Main: 165912576 21:28:34 INFO - PROCESS | 5465 | 21:28:36 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:37 INFO - PROCESS | 5465 | RSS: Main: 169275392 21:28:37 INFO - PROCESS | 5465 | 21:28:40 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-dft) 21:28:41 INFO - PROCESS | 5465 | RSS: Main: 172695552 21:28:41 INFO - PROCESS | 5465 | 21:28:44 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-fft) 21:28:44 INFO - PROCESS | 5465 | RSS: Main: 164352000 21:28:44 INFO - PROCESS | 5465 | 21:28:46 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50484/tests/kraken/driver.html?testName=audio-oscillator) 21:28:47 INFO - PROCESS | 5465 | RSS: Main: 164405248 21:28:47 INFO - PROCESS | 5465 | 21:28:49 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:28:50 INFO - PROCESS | 5465 | RSS: Main: 165515264 21:28:50 INFO - PROCESS | 5465 | 21:28:53 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50484/tests/kraken/driver.html?testName=imaging-darkroom) 21:28:54 INFO - PROCESS | 5465 | RSS: Main: 165978112 21:28:54 INFO - PROCESS | 5465 | 21:28:57 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50484/tests/kraken/driver.html?testName=imaging-desaturate) 21:28:58 INFO - PROCESS | 5465 | RSS: Main: 164958208 21:28:58 INFO - PROCESS | 5465 | 21:29:01 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50484/tests/kraken/driver.html?testName=json-parse-financial) 21:29:02 INFO - PROCESS | 5465 | RSS: Main: 166326272 21:29:02 INFO - PROCESS | 5465 | 21:29:03 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:04 INFO - PROCESS | 5465 | RSS: Main: 166535168 21:29:04 INFO - PROCESS | 5465 | 21:29:06 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:07 INFO - PROCESS | 5465 | RSS: Main: 166244352 21:29:07 INFO - PROCESS | 5465 | 21:29:09 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:09 INFO - PROCESS | 5465 | RSS: Main: 167002112 21:29:09 INFO - PROCESS | 5465 | 21:29:12 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:13 INFO - PROCESS | 5465 | RSS: Main: 167301120 21:29:13 INFO - PROCESS | 5465 | 21:29:16 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:16 INFO - PROCESS | 5465 | RSS: Main: 167759872 21:29:16 INFO - PROCESS | 5465 | 21:29:18 INFO - PROCESS | 5465 | Cycle 1(1): loaded http://localhost:50484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50484/tests/kraken/driver.html?testName=ai-astar) 21:29:18 INFO - PROCESS | 5465 | RSS: Main: 168706048 21:29:18 INFO - PROCESS | 5465 | 21:29:18 INFO - PROCESS | 5465 | __start_tp_report 21:29:18 INFO - PROCESS | 5465 | _x_x_mozilla_page_load 21:29:18 INFO - PROCESS | 5465 | _x_x_mozilla_page_load_details 21:29:18 INFO - PROCESS | 5465 | |i|pagename|runs| 21:29:18 INFO - PROCESS | 5465 | |0;ai-astar;115;108;115;114;117;127;115;114;114;115 21:29:18 INFO - PROCESS | 5465 | |1;audio-beat-detection;168;132;160;201;133;173;158;144;189;140 21:29:18 INFO - PROCESS | 5465 | |2;audio-dft;162;162;164;177;163;163;161;163;165;163 21:29:18 INFO - PROCESS | 5465 | |3;audio-fft;74;73;76;164;75;75;74;74;155;76 21:29:18 INFO - PROCESS | 5465 | |4;audio-oscillator;97;105;146;101;95;95;145;96;94;142 21:29:18 INFO - PROCESS | 5465 | |5;imaging-gaussian-blur;119;118;117;117;117;118;124;118;117;118 21:29:18 INFO - PROCESS | 5465 | |6;imaging-darkroom;149;147;148;150;148;148;149;149;148;148 21:29:18 INFO - PROCESS | 5465 | |7;imaging-desaturate;95;96;96;96;95;94;96;96;96;95 21:29:18 INFO - PROCESS | 5465 | |8;json-parse-financial;66;69;68;67;68;67;68;80;65;64 21:29:18 INFO - PROCESS | 5465 | |9;json-stringify-tinderbox;64;64;65;73;65;64;64;65;65;65 21:29:18 INFO - PROCESS | 5465 | |10;stanford-crypto-aes;78;78;79;88;79;81;80;80;79;80 21:29:18 INFO - PROCESS | 5465 | |11;stanford-crypto-ccm;142;134;138;146;133;137;138;132;214;138 21:29:19 INFO - PROCESS | 5465 | |12;stanford-crypto-pbkdf2;175;175;175;181;175;170;177;180;179;176 21:29:19 INFO - PROCESS | 5465 | |13;stanford-crypto-sha256-iterative;73;75;72;73;73;74;72;75;72;72 21:29:19 INFO - PROCESS | 5465 | __end_tp_report 21:29:19 INFO - PROCESS | 5465 | __start_cc_report 21:29:19 INFO - PROCESS | 5465 | _x_x_mozilla_cycle_collect,934 21:29:19 INFO - PROCESS | 5465 | __end_cc_report 21:29:19 INFO - PROCESS | 5465 | __startTimestamp1461472158995__endTimestamp 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | ------- Summary: start ------- 21:29:19 INFO - PROCESS | 5465 | Number of tests: 14 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:4.70 (4.1%) stddev-sans-first:4.98 21:29:19 INFO - PROCESS | 5465 | Values: 115.0 108.0 115.0 114.0 117.0 127.0 115.0 114.0 114.0 115.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#1] audio-beat-detection Cycles:10 Average:159.80 Median:164.00 stddev:23.40 (14.3%) stddev-sans-first:24.63 21:29:19 INFO - PROCESS | 5465 | Values: 168.0 132.0 160.0 201.0 133.0 173.0 158.0 144.0 189.0 140.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.60 (2.8%) stddev-sans-first:4.80 21:29:19 INFO - PROCESS | 5465 | Values: 162.0 162.0 164.0 177.0 163.0 163.0 161.0 163.0 165.0 163.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.50 stddev:35.86 (48.1%) stddev-sans-first:37.47 21:29:19 INFO - PROCESS | 5465 | Values: 74.0 73.0 76.0 164.0 75.0 75.0 74.0 74.0 155.0 76.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:94.50 stddev:22.84 (24.2%) stddev-sans-first:23.61 21:29:19 INFO - PROCESS | 5465 | Values: 97.0 105.0 146.0 101.0 95.0 95.0 145.0 96.0 94.0 142.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:2.11 (1.8%) stddev-sans-first:2.22 21:29:19 INFO - PROCESS | 5465 | Values: 119.0 118.0 117.0 117.0 117.0 118.0 124.0 118.0 117.0 118.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 21:29:19 INFO - PROCESS | 5465 | Values: 149.0 147.0 148.0 150.0 148.0 148.0 149.0 149.0 148.0 148.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 21:29:19 INFO - PROCESS | 5465 | Values: 95.0 96.0 96.0 96.0 95.0 94.0 96.0 96.0 96.0 95.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:68.00 stddev:4.42 (6.5%) stddev-sans-first:4.61 21:29:19 INFO - PROCESS | 5465 | Values: 66.0 69.0 68.0 67.0 68.0 67.0 68.0 80.0 65.0 64.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:2.72 (4.2%) stddev-sans-first:2.83 21:29:19 INFO - PROCESS | 5465 | Values: 64.0 64.0 65.0 73.0 65.0 64.0 64.0 65.0 65.0 65.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.90 (3.6%) stddev-sans-first:2.96 21:29:19 INFO - PROCESS | 5465 | Values: 78.0 78.0 79.0 88.0 79.0 81.0 80.0 80.0 79.0 80.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:138.00 stddev:24.53 (17.8%) stddev-sans-first:25.99 21:29:19 INFO - PROCESS | 5465 | Values: 142.0 134.0 138.0 146.0 133.0 137.0 138.0 132.0 214.0 138.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:3.16 (1.8%) stddev-sans-first:3.32 21:29:19 INFO - PROCESS | 5465 | Values: 175.0 175.0 175.0 181.0 175.0 170.0 177.0 180.0 179.0 176.0 21:29:19 INFO - PROCESS | 5465 | 21:29:19 INFO - PROCESS | 5465 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.20 (1.6%) stddev-sans-first:1.27 21:29:19 INFO - PROCESS | 5465 | Values: 73.0 75.0 72.0 73.0 73.0 74.0 72.0 75.0 72.0 72.0 21:29:19 INFO - PROCESS | 5465 | -------- Summary: end -------- 21:29:19 INFO - PROCESS | 5465 | 21:29:20 INFO - TEST-INFO | 5465: exit 0 21:29:20 INFO - TEST-OK | kraken | took 64488ms 21:29:20 INFO - SUITE-END | took 1179s 21:29:20 INFO - Completed test suite (00:19:39) 21:29:20 INFO - javascript benchmark 21:29:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.788976881849, 2681.6245725598415, 2702.1083042595947, 2707.56678931371, 2708.878100485478, 4699.2951057341415, 4718.598919091873, 4726.314684370765, 4729.787159577819, 4776.641751868607, 4668.719876807394, 4754.524547545244, 4787.545183207599, 4834.129856625806, 4854.223324268118, 4408.096340250249, 4451.532589078149, 4458.4872739634875, 4485.887852803673, 4530.093981203756, 4415.028693687384, 4476.6418686505, 4501.954980450187, 4523.208438523246, 4525.456945166585, 4321.092570560186, 4402.7798610069685, 4419.160359531678, 4457.799399027052, 4467.977660111678, 4390.275604525282, 4416.712913660602, 4435.135148646015, 4440.866773996785, 4479.037007043501, 4376.7811609419405, 4391.704447188087, 4396.1427521633295, 4411.42651455312, 4450.376947227391, 4617.492075871652, 4683.227267500858, 4685.133250348662, 4711.222648263067, 4730.455997560291, 5078.974605126988, 5091.592672586185, 5112.565431938289, 5115.309433226504, 5137.48625137487, 5132.3327967364, 5140.485951404867, 5144.485551444863, 5153.716545589991, 5189.844304670828, 4768.976155119202, 4769.904601907942, 4772.570468657837, 4789.521047895218, 4820.927686084711, 5152.330197074356, 5208.791648334024, 5210.348706411699, 5241.816536421207, 5250.028744682169, 4968.453470118284, 5012.064429503631, 5038.622103342191, 5068.949310506848, 5160.948390516121, 5140.922886156711, 5174.741262936838, 5196.142636464941, 5197.792088316501, 5225.111731005738, 4999.825006124768, 5106.795728170831, 5196.506331898464, 5199.636025478256, 5223.268742376071, 4928.137575924199, 4997.175466048134, 5014.648974571818, 5040.546350828443, 5053.090443720165, 4372.672049596293, 4382.780860956939, 4385.693001489929, 4416.984093658477, 4431.290993441034, 3791.184895247535, 3803.144292534213, 3816.694664426839, 3842.8462861485227, 3862.1503269280715, 4269.509006464296, 4331.913361732748, 4372.978135109304, 4414.84548040817, 4418.447694038246, 5150.510701483353, 5193.506616871391, 5203.19350500673, 5215.139501982207, 5250.868728281747, 4403.097365040159, 4441.933370999438, 4454.242778727624, 4459.554044595515, 4494.325851122358, 4467.754273514923, 4583.9312410313205, 4651.813927442932, 4667.159911216014, 4681.508441613581, 4706.152892479249, 4729.952700472952, 4759.143354196278, 4762.357081793983, 4793.976030119967, 5044.596432285335, 5059.241113832954, 5061.266116413173, 5091.159958606789, 5118.692878427306, 4686.601638860735, 4775.379200703886, 4805.327254184347, 4811.08589368019, 4823.155947709207, 5014.974925125351, 5029.924551131663, 5034.244863270393, 5038.924416133687, 5081.263216833612, 5022.874428139326, 5119.257707632298, 5120.078385890575, 5122.487751224997, 5125.8974820502635, 4877.195262781602, 4879.56083952446, 5046.873828154326, 5074.238864170404, 5093.516115968977, 4960.379952505937, 4967.081089998362, 4976.527229913152, 4980.103581355391, 4985.775640096132, 4813.1336359454235, 4847.587955023862, 4849.393825771778, 4885.828995985124, 4955.306257123933, 4882.2920676501, 5009.699418034929, 5016.498350164954, 5054.444011158696, 5075.695458272516, 4921.114199444134, 4922.335484709519, 4923.5814955729165, 4929.16204245272, 4935.235038568884], "value": 4699.766712364294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2433188191588, 599.2150283129101, 604.0425924909019, 618.7617767159644, 645.9386358295964, 34137.82931085344, 35649.82175089124, 35726.642733572655, 35814.283714325764, 35835.10412239695, 37718.0, 38766.22467550647, 38794.224115517674, 38797.22405551887, 38854.41718374227, 7592.468527203098, 7814.492058016211, 7818.569978651172, 7820.843583128334, 7823.491473054261, 7622.961885190566, 7729.690812367527, 7752.372001879584, 7759.5344279343135, 7765.262300081483, 7861.489003214772, 7912.0, 7979.880301795478, 7994.280514753671, 8007.439479236456, 7884.0, 7942.761717148466, 7958.801029974239, 7968.641411136484, 7980.122186559473, 7748.961255193744, 7863.606819658994, 7866.646000929914, 7895.210478952116, 7896.5262084274555, 37949.81025094857, 37987.430188547194, 38176.236475270336, 38178.80910595429, 38268.0, 3225.6774322567558, 3255.153660048381, 3276.3774882772195, 3360.0, 3488.8081155536433, 28850.278743031384, 29026.85486572575, 29078.27304317388, 29228.41543169146, 29414.264643384086, 3496.8950931472095, 3522.4892390603477, 3559.056849934769, 3624.039629498185, 3743.700503959704, 230920.0, 231065.0, 232687.8365608178, 232963.0, 233951.0, 51909.0, 52950.0, 52963.205551915984, 52989.205161922604, 53078.0, 55702.0, 55799.16301255403, 66187.66906165438, 68599.3140068603, 68952.3104768956, 14539.854601454063, 14594.781078283835, 14652.12087274767, 14666.706665866623, 14830.629234269014, 10921.344719316867, 10977.560897564168, 11008.669739907815, 11014.834777478345, 11021.063209627111, 18753.906230469034, 18776.530586735167, 18866.0, 18970.14634341458, 19096.61806763857, 7080.36276735086, 7091.60996145217, 7174.0, 7263.709451621981, 7340.559566426032, 845.1548451548451, 860.8421672850006, 872.0799556467987, 890.1587999340561, 918.8529835226332, 26106.477870442486, 26379.0, 26437.471250575265, 26556.8672156638, 26578.601320979815, 1000.9899901000897, 1004.5077911823154, 1013.4679293371039, 1043.014351437899, 1104.812181929074, 14333.140011599337, 14358.138511689333, 14429.639259018608, 14437.35031923566, 14483.058601190889, 375756.0, 381727.0, 382589.0, 385644.0, 385859.0, 49303.50696493061, 50544.0, 50862.0, 50901.0, 51004.74497627488, 1256.39065053449, 1273.808928660727, 1275.1775105057372, 1278.0606254403006, 1284.9550265740654, 26808.463830722885, 27436.83031146857, 27899.16302510928, 28186.71813281923, 28408.147755567366, 41986.1602767949, 47803.28295075507, 49706.0, 49755.0, 49819.750901245265, 244672.0, 247363.0, 247675.0, 247675.0, 247889.0, 38285.2342953145, 38454.0, 39275.41086883642, 39298.214035718556, 39396.0, 42370.15259694851, 42773.14453710971, 42785.358219626105, 43585.782071089445, 43676.0, 36435.45346819747, 36960.81519592492, 37074.443883341235, 37558.62441375551, 38130.23739525139, 35936.82031589825, 35949.46075808813, 36395.45406818847, 36728.63271367252, 37429.812850935574, 35593.288134237686, 36563.63436365602, 37119.814400927826, 37378.25243495169, 37529.061773455884, 31640.841795790875, 33180.33639327248, 33232.0, 33446.66553334533, 33688.831555842065, 25516.74483255218, 25878.741212587633, 26026.479470410864, 26048.47903041891, 26322.4735505285], "value": 17836.695684691855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.1750202061526, 384.63843986652546, 388.4057392189949, 390.0891418537714, 403.58229232744117, 15299.54101376959, 16791.83208167918, 17468.0, 17755.91122044391, 17762.200700968457, 16525.421610243644, 17134.485965421056, 17180.0, 17515.5621109472, 17516.64966700665, 4363.520012798597, 5054.9494505054845, 5093.414257360396, 5108.5913126949945, 5115.897682046357, 3618.1678214010794, 5642.7178641067785, 6004.549658775588, 6008.549358798107, 6020.879582408349, 5108.6168537359845, 5891.204687367193, 5920.615160014607, 5960.821175364725, 5979.491743201833, 5320.201969704536, 5369.731513424314, 5374.086405311087, 5398.028354896137, 5407.270018547485, 5010.0981823271795, 5251.448597897204, 5256.26412302278, 5279.788808447657, 5282.260483532308, 12529.43617537213, 12553.184043037174, 13389.0, 18772.155253013647, 19144.80855191444, 1817.318505560415, 1864.049334839228, 1977.831884289837, 1987.3739771971927, 2008.829249513793, 8498.872516912252, 9289.396189247676, 10509.789804203872, 13193.34033298341, 13507.324633768272, 1702.361614394602, 1726.231826837058, 1776.3693888669595, 1806.223323970692, 1847.5381154711322, 70301.64849175721, 71714.28285717129, 71971.2802871975, 72209.63895180543, 72615.99999999948, 9718.465484398284, 9972.950135249423, 10060.0, 10127.240456965757, 10294.227932905062, 13942.302884855919, 13991.58025259244, 14039.85960140406, 14136.363863626162, 14136.363863626162, 7220.675069621774, 7240.710371585077, 7279.41764658826, 7331.706731730777, 7427.145878224073, 6824.146981627297, 6835.248122706498, 6922.203946546111, 7034.19106802714, 7040.92959070413, 4355.128974205171, 4390.341448782644, 4407.625351845065, 4417.712848664826, 4423.5576442355505, 1656.2546853915785, 1777.6355847051323, 1868.4394681595468, 1876.6903460929068, 1897.6655227545436, 914.9817003659889, 922.4649703172144, 966.4346357380871, 969.471637957315, 985.5170966226641, 15974.520764377086, 16171.191440428167, 16263.024218546925, 16650.0, 16740.246688898784, 885.3138817416553, 894.1952242981368, 899.8515244984504, 937.1659223291276, 946.5125460387906, 9012.324075694349, 9154.86267705985, 9222.907770922338, 9260.907390926139, 9418.293627977791, 254621.0, 263473.0, 394781.0, 396966.0, 399192.0, 83561.58219208865, 83686.58156709178, 85794.42336248123, 86381.56809215914, 87491.12508874957, 935.4340623922565, 976.1800087926176, 1006.06938581813, 1008.5864795433837, 1011.1354791653177, 15385.538433847003, 15446.2276886153, 15455.227238637799, 15471.149086799884, 15552.766708499608, 35532.467012995345, 35712.8214358937, 36328.0, 36718.63281367259, 37265.25469490649, 48537.75731121463, 51314.0, 51344.48655513547, 51523.22715159201, 52087.0, 7258.854822903407, 7403.629818509161, 7450.888236676563, 7642.273983971514, 7643.235676432312, 5217.0, 5500.614956952975, 10313.432761198206, 10785.298955567863, 10941.617043403443, 8396.118407567117, 9303.023182565734, 9348.906510935076, 9552.188064014637, 9565.426074435556, 9177.21993630549, 9386.67146649864, 9398.483083430478, 9457.290703197425, 9750.073742994404, 9561.0, 9591.136797688241, 9611.231101511723, 9642.71071867845, 9836.311458198144, 7174.461915356264, 7287.27127287267, 7310.853782924418, 7361.705531778883, 7520.8495830082, 8764.605592748214, 8928.15182557656, 8991.41555798871, 9163.175314221751, 10021.549030293509], "value": 8077.336572121353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.3051821498177, 1348.5414958913973, 1380.3581334679375, 1536.1474381718142, 1553.277725857476, 6995.370416662499, 7670.0, 7736.303732664059, 7870.921290787091, 7929.0, 7789.844203115934, 7880.527168369902, 7886.684532618703, 7926.326262267714, 7932.167122452146, 2219.622664147099, 2243.955120897581, 2250.639897616382, 2252.2905284835224, 2255.030336955109, 2150.2689085710854, 2200.7249093863265, 2227.4988127671227, 2231.3306008197474, 2234.2850287907877, 2163.3834357208198, 2202.878841663708, 2203.3389983005113, 2208.1608988584394, 2228.520868013377, 2174.9891250543806, 2177.4556360909774, 2190.3428971308545, 2192.71494705688, 2193.8573992690503, 2156.0728886578763, 2166.328438184168, 2172.435166856613, 2175.5213852952324, 2176.62997290461, 7945.4438189326775, 7983.241592048804, 8049.114597394282, 8053.758387248392, 8121.4721043132, 4769.618430525549, 4933.235348520985, 4945.258211268302, 4948.752562371867, 4956.281339205831, 2894.2266107517903, 3037.104054303986, 3083.784135110543, 3109.4247564200696, 3110.9844450777828, 939.3893968920188, 957.2916042128844, 957.9712608621752, 979.2264111352094, 985.3250523391499, 10846.728831779268, 10884.564617415293, 10995.285306455055, 10996.505157267942, 11060.281081729743, 4326.459192600925, 4387.473503179639, 4514.7291162530355, 4542.84100056503, 4548.522405147478, 9262.490563019099, 9263.16631503168, 9275.0261222572, 9327.580258888367, 9361.859572106288, 4946.282788995575, 4949.529794669501, 4957.628177886673, 4974.154393752999, 4977.701337919736, 3892.279928213233, 4374.343848422762, 4471.821127154877, 4477.395551600557, 4500.887477813016, 3708.0915175781565, 3744.925101497955, 3803.904902377463, 3866.3040652682225, 3878.3212937735784, 1221.7190046289404, 1264.8988080953502, 1265.487477571585, 1276.9553065642658, 1280.8719128087116, 813.1380736419414, 836.9665213391396, 844.9408541402042, 884.951327676984, 928.7074571509953, 5295.973520132375, 5339.652922560022, 5466.781328746885, 5516.117421212587, 5741.282339707536, 855.7774978505508, 861.7845538615346, 863.935204859638, 869.1352104655908, 870.4907629037084, 3636.2182130841998, 3672.5225720656144, 3737.4767532545466, 3751.0622344413896, 3771.377722675728, 8826.911730882737, 9001.819963600692, 9106.180443760093, 9155.54222288883, 9170.266378689688, 9175.908240917639, 9182.908170918205, 9186.081391860895, 9263.305252106118, 9277.350585458953, 7202.92797072033, 7494.138174110047, 7512.887306690294, 7555.0, 7606.239376062349, 5181.896362072662, 5426.620136590401, 5438.972805135949, 5455.236266922713, 5622.437756224344, 8875.778105547413, 8907.0, 9083.545822708706, 9188.954055229948, 9223.44659320443, 8817.911820881709, 9049.049849765679, 9211.677591284273, 9213.355065145644, 9230.907690923004, 6074.696265186812, 6191.288001879841, 6399.936000639934, 6439.452646525097, 6637.435817955527, 7513.323800857949, 7534.284242996907, 7561.054868141482, 7601.847963040819, 7633.274838890296, 6619.735210591522, 6866.416354609714, 6968.338007889242, 6988.580685158907, 7149.392301654418, 6762.560433571802, 6794.150731158606, 6902.0, 6935.306469353226, 6952.652367381712, 6180.783672571439, 6359.586626869239, 6660.933390666031, 6742.696578653874, 6753.696083676148, 4533.727976321431, 4544.454665440168, 4573.245414506702, 4605.631549476101, 4647.814087436464, 4663.114008338541, 4680.92978605328, 4722.693024953367, 4747.9791844753545, 4755.714657120584], "value": 4221.2778647330415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.88287774962146, 321.46797050880787, 329.74444805275914, 331.7362696656157, 333.8864785972769, 5420.891582168354, 5449.555867695064, 5461.37194222664, 5491.1763235514645, 5506.091494903336, 5348.171033489805, 5358.919616205751, 5369.643972517177, 5374.113271310239, 5377.919331210025, 3927.4894263745673, 4078.714489985702, 4212.705110642256, 4216.346466297713, 4226.070264541811, 4213.1363070570615, 4214.831406743727, 4216.810243539048, 4216.852410165645, 4230.153969206156, 4177.394277829713, 4202.747835129902, 4204.579542045802, 4207.495100587934, 4219.177260434217, 4115.362118871565, 4185.476815398075, 4200.1389715108635, 4202.453681021479, 4223.303154979425, 3707.3326801175776, 3708.5364329458816, 3722.5346831646043, 3724.515812944327, 3733.178700685845, 5132.692038477703, 5148.768305426265, 5161.612879034087, 5162.277281180638, 5200.29795977542, 4822.493638167977, 4902.975485122587, 4913.94350214702, 4922.975385123087, 4923.901521969577, 5735.0, 5738.942610573882, 5747.568932330092, 5751.166080918285, 5762.9135562966585, 4062.2687916175078, 4105.938410923838, 4107.260693075275, 4119.526254480743, 4133.793310334471, 5685.260916080924, 5970.164177015265, 6016.639001659914, 6021.2473440819895, 6026.728797204137, 4207.600277973587, 4217.304144816132, 4242.8727138185905, 4243.872683819491, 4244.04508985482, 4306.569343065668, 4308.526062133163, 4310.073334233155, 4318.157959197989, 4327.394164816928, 4489.191945449785, 4736.455307639666, 4813.181759100961, 4841.298011788342, 4883.194272944925, 5729.770809167587, 5733.684647344436, 5745.6552606843725, 5747.85630359236, 5772.6536407815665, 1431.9546730886511, 1453.4331610671848, 1459.496473716566, 1460.6056364781662, 1462.5246794791735, 875.899271583776, 936.3539157980971, 938.442185971298, 955.9904400956041, 957.9904200958041, 4826.066755594179, 4852.4662287148385, 4873.342098816685, 4904.779284932187, 4905.484924082992, 5796.478316951495, 5825.88348233033, 5831.795887144014, 5840.678762668009, 5840.795572154954, 4706.0, 4873.390826146731, 4889.364382630307, 4893.730844803499, 4949.57928576075, 3167.7940933839227, 3199.104250809777, 3205.4550726376574, 3208.743300535998, 3209.534617480452, 5509.917351239735, 5565.638233514808, 5574.303212098488, 5581.274434323594, 5582.24639673647, 5948.494377977834, 6074.42292982166, 6106.816795496142, 6132.6627035513475, 6132.877342453126, 5536.307961504812, 5555.111182210827, 5558.166275058693, 5571.331440227199, 5573.6098473106495, 5641.887162256814, 5960.672163031075, 5967.224260846062, 5973.611715238496, 5997.940020599738, 5847.415258474119, 5895.67573783446, 5909.320428150818, 5911.970440147772, 5919.644821310735, 5569.972150139223, 5588.469095435927, 5591.6365436246515, 5603.607747457639, 5622.943770562406, 3995.5405128410603, 4099.733517321364, 4119.402686610485, 4146.1500392420085, 4146.79266036703, 5902.350741418355, 5960.672163031075, 5993.40395762539, 6007.519398448201, 6016.699165041818, 5575.776968921197, 5726.590525295583, 5763.406467089911, 5775.653460792366, 5791.739371728367, 5713.314402271754, 5722.971385143214, 5735.7705691773535, 5779.682117483579, 5782.710864456844, 5393.83818485446, 5660.405657406078, 5666.631668941505, 5698.6580805151825, 5710.885782284248, 5581.804636837691, 5764.682942438206, 5790.189373487631, 5800.912986305293, 5804.65172089676, 5642.633228840113, 5657.943420565906, 5685.175649530877, 5692.857678558069, 5695.946249943774], "value": 4298.616874924438, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.2022772104172, 763.4312437234258, 778.540661010004, 779.7465823607329, 798.6046906781144, 14088.788668169973, 14524.0, 14605.342759575818, 14607.269636518171, 14610.123392596424, 14026.088304260216, 14040.227787471686, 14055.78916316256, 14105.294735263247, 14133.929330353334, 650.6746626686656, 821.6343727041469, 827.7682248970298, 828.0229329391346, 828.3166387730147, 811.5333683132222, 834.3408707121367, 835.0980940584185, 835.9205875441824, 836.4437648963432, 855.3371137368558, 865.523961820999, 868.179570306061, 869.3393021303791, 869.5391442535466, 862.2326129744532, 865.809521905183, 867.0116067682847, 867.0505796153266, 867.0982178534317, 621.909823075656, 628.2272804450506, 628.9905651415232, 629.2354788931425, 631.2803404119308, 12923.67690807728, 12924.224546527144, 12924.935375323157, 12945.223286602833, 12963.546275880299, 12247.69380765479, 12257.387130643432, 12296.0, 12314.50741970329, 12490.75018499634, 9950.850737238947, 9957.203423726085, 9989.500524973722, 10014.0, 10036.447995360253, 3211.14904550292, 3245.107595411257, 3278.1149089745873, 3280.5735254417013, 3369.5114208439886, 43883.341749873776, 43912.0, 44071.77964110191, 44215.33676994847, 44415.555844441464, 9694.46680432583, 9868.210543156674, 9911.504424778732, 9987.151092157103, 10022.098011179029, 16744.581385465463, 16834.0, 16895.915520422564, 16907.32370705158, 16941.06824124685, 6702.128723265944, 6713.56361836479, 6833.180018397725, 6878.209005964378, 6931.965340173267, 3817.3319669057805, 3867.61323867611, 3911.6870650347905, 3943.9942814582096, 3953.0, 2868.6127372804403, 2927.370615317717, 2929.956050659242, 2930.3406733484794, 2932.3841993181245, 520.1625383133153, 522.3027258609799, 522.5662699959025, 529.4440837121008, 533.1017235957424, 585.7247093865876, 613.1936503497975, 614.7110857896781, 618.2025187508065, 626.6647343671114, 7758.0, 7844.176361482077, 7934.246246606564, 8057.879131813028, 8487.533185674847, 481.38863643172976, 519.2652396858479, 520.2274622186051, 550.9284441760736, 580.3992867382324, 3668.6514781095752, 3914.72596918213, 3917.941230881539, 3987.980060099681, 3997.480327557399, 51063.489365106616, 51241.7437912808, 52031.47968520342, 52061.47938520642, 52125.73937130366, 45183.322250166275, 46474.0, 47121.5287847124, 47516.0, 48199.5180048195, 41533.0, 42098.78950605227, 42173.0, 42346.94132646647, 43635.0, 7172.49792514519, 7389.852202956018, 7486.588237646982, 7544.735934242275, 7580.583067931317, 27933.441331173668, 27960.44079118447, 28053.57919631248, 28550.85724571364, 28652.14043578696, 34751.0, 35819.64180358163, 37990.43014354732, 38184.23631527298, 38234.80882595569, 9727.416355018722, 9752.073553012453, 9795.118439340493, 9806.264530160124, 10086.646967356108, 10493.580256789643, 10574.365538067434, 10784.568617255221, 10973.780524389627, 10996.945015274872, 9796.9020309796, 9913.256505762241, 9942.30403871722, 10134.037266459969, 10198.694039178836, 9983.301168918106, 10209.0, 10304.896951030394, 10359.792804144026, 10714.571417143226, 9554.85667714971, 9778.0, 10036.49817509107, 10123.544440500047, 10289.639862604772, 8601.698940537051, 8634.697785577475, 8810.163034511712, 8827.955860220658, 9254.12085851843, 7931.960340198262, 8208.384371172067, 8217.178282171735, 8241.217084377215, 8455.0], "value": 5873.30876950602, "unit": "score"}], "name": "dromaeo_css", "value": 6452.477329077291, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 115.0, 114.0, 117.0, 127.0, 115.0, 114.0, 114.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 132.0, 160.0, 201.0, 133.0, 173.0, 158.0, 144.0, 189.0, 140.0], "value": 159.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 177.0, 163.0, 163.0, 161.0, 163.0, 165.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 164.0, 75.0, 75.0, 74.0, 74.0, 155.0, 76.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 105.0, 146.0, 101.0, 95.0, 95.0, 145.0, 96.0, 94.0, 142.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 117.0, 118.0, 124.0, 118.0, 117.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 150.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 94.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 67.0, 68.0, 67.0, 68.0, 80.0, 65.0, 64.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 73.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 88.0, 79.0, 81.0, 80.0, 80.0, 79.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 138.0, 146.0, 133.0, 137.0, 138.0, 132.0, 214.0, 138.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 175.0, 181.0, 175.0, 170.0, 177.0, 180.0, 179.0, 176.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 73.0, 73.0, 74.0, 72.0, 75.0, 72.0, 72.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1613.3, "alertThreshold": 2.0}]} 21:29:20 INFO - Return code: 0 21:29:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:29:20 ERROR - # TBPL SUCCESS # 21:29:20 INFO - Running post-action listener: _resource_record_post_action 21:29:20 INFO - Running post-run listener: _resource_record_post_run 21:29:21 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 377462784; Read time: 0; Write time: 212860 21:29:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13623296; Read time: 0; Write time: 4824 21:29:21 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 294805504; Read time: 0; Write time: 148636 21:29:21 INFO - Running post-run listener: _upload_blobber_files 21:29:21 INFO - Blob upload gear active. 21:29:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29:21 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 21:29:21 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'] 21:29:21 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 21:29:22 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:29:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:29:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:23 INFO - (blobuploader) - INFO - Done attempting. 21:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:25 INFO - (blobuploader) - INFO - Done attempting. 21:29:25 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:25 INFO - Return code: 0 21:29:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/374b125a7360ba707dec1680659a71790e2bf486dc3871bfb229fa376a9770aaa59989ef70b7e4d9b4983ae70d6bf02d8a239430d65af8dfe5f356ac70fe4c13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0949ac266090eeb75baf3f2e889e70bb3e3843e35eb87e388ec0e43b7c7bbf7736c2b2af87cf48646b7e192f591701e353c7403c62c6643a73d1212687c0414b"} 21:29:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:25 INFO - Contents: 21:29:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/374b125a7360ba707dec1680659a71790e2bf486dc3871bfb229fa376a9770aaa59989ef70b7e4d9b4983ae70d6bf02d8a239430d65af8dfe5f356ac70fe4c13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0949ac266090eeb75baf3f2e889e70bb3e3843e35eb87e388ec0e43b7c7bbf7736c2b2af87cf48646b7e192f591701e353c7403c62c6643a73d1212687c0414b"} 21:29:25 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:25 INFO - Copying logs to upload dir... 21:29:25 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.107565 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-23 21:29:24.571666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:24.575060) ========= 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=4300f881736b422476174874000001bc-1461463055.639292-1051849193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/374b125a7360ba707dec1680659a71790e2bf486dc3871bfb229fa376a9770aaa59989ef70b7e4d9b4983ae70d6bf02d8a239430d65af8dfe5f356ac70fe4c13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0949ac266090eeb75baf3f2e889e70bb3e3843e35eb87e388ec0e43b7c7bbf7736c2b2af87cf48646b7e192f591701e353c7403c62c6643a73d1212687c0414b"} build_url:https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011531 build_url: 'https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/374b125a7360ba707dec1680659a71790e2bf486dc3871bfb229fa376a9770aaa59989ef70b7e4d9b4983ae70d6bf02d8a239430d65af8dfe5f356ac70fe4c13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0949ac266090eeb75baf3f2e889e70bb3e3843e35eb87e388ec0e43b7c7bbf7736c2b2af87cf48646b7e192f591701e353c7403c62c6643a73d1212687c0414b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:24.599741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:24.600054) ========= 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=4300f881736b422476174874000001bc-1461463055.639292-1051849193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:24.684549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 21:29:24.685016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 21:29:24.685429) ========= ========= Total master_lag: 0.17 =========