builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1461470912.77 results: success (0) buildid: 20160423200647 builduid: e22b5d514c594dfea2eb74cda23d211c revision: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:32.767864) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:32.768410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:32.768784) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:32.812026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:32.812325) ========= 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=62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 21:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 126K=0.09s 2016-04-23 21:08:33 (126 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.046339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.046670) ========= 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=62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015369 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.097072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.097460) ========= 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=62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 21:08:33,576 truncating revision to first 12 chars 2016-04-23 21:08:33,576 Setting DEBUG logging. 2016-04-23 21:08:33,576 attempt 1/10 2016-04-23 21:08:33,576 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:34,085 unpacking tar archive at: fx-team-ef9c1cc0a76c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.807274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.918304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.918642) ========= script_repo_revision: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.919095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.919395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 21:08:33.928284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-23 21:08:33.928580) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:08:34 INFO - MultiFileLogger online at 20160423 21:08:34 in /builds/slave/test 21:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:08:34 INFO - {'append_to_log': False, 21:08:34 INFO - 'base_work_dir': '/builds/slave/test', 21:08:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:08:34 INFO - 'branch': 'Fx-Team-Non-PGO', 21:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:08:34 INFO - 'config_files': ('talos/linux_config.py',), 21:08:34 INFO - 'default_actions': ('clobber', 21:08:34 INFO - 'read-buildbot-config', 21:08:34 INFO - 'download-and-extract', 21:08:34 INFO - 'populate-webroot', 21:08:34 INFO - 'create-virtualenv', 21:08:34 INFO - 'install', 21:08:34 INFO - 'run-tests'), 21:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:08:34 INFO - 'download_minidump_stackwalk': True, 21:08:34 INFO - 'download_symbols': 'ondemand', 21:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:08:34 INFO - 'installer_path': 'installer.exe', 21:08:34 INFO - 'log_level': 'info', 21:08:34 INFO - 'log_name': 'talos', 21:08:34 INFO - 'log_to_console': True, 21:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:08:34 INFO - 'opt_config_files': (), 21:08:34 INFO - 'pip_index': False, 21:08:34 INFO - 'sps_profile': False, 21:08:34 INFO - 'sps_profile_interval': 0, 21:08:34 INFO - 'suite': 'dromaeojs', 21:08:34 INFO - 'system_bits': '32', 21:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:08:34 INFO - 'title': 'talos-linux64-ix-018', 21:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:08:34 INFO - 'use_talos_json': True, 21:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:08:34 INFO - 'work_dir': 'build'} 21:08:34 INFO - ##### 21:08:34 INFO - ##### Running clobber step. 21:08:34 INFO - ##### 21:08:34 INFO - Running pre-action listener: _resource_record_pre_action 21:08:34 INFO - Running main action method: clobber 21:08:34 INFO - rmtree: /builds/slave/test/build 21:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:08:34 INFO - Running post-action listener: _resource_record_post_action 21:08:34 INFO - ##### 21:08:34 INFO - ##### Running read-buildbot-config step. 21:08:34 INFO - ##### 21:08:34 INFO - Running pre-action listener: _resource_record_pre_action 21:08:34 INFO - Running main action method: read_buildbot_config 21:08:34 INFO - Using buildbot properties: 21:08:34 INFO - { 21:08:34 INFO - "project": "", 21:08:34 INFO - "product": "firefox", 21:08:34 INFO - "script_repo_revision": "production", 21:08:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:08:34 INFO - "repository": "", 21:08:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:08:34 INFO - "buildid": "20160423200647", 21:08:34 INFO - "pgo_build": "False", 21:08:34 INFO - "basedir": "/builds/slave/test", 21:08:34 INFO - "buildnumber": 1592, 21:08:34 INFO - "slavename": "talos-linux64-ix-018", 21:08:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:08:34 INFO - "platform": "ubuntu64_hw", 21:08:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:08:34 INFO - "branch": "fx-team", 21:08:34 INFO - "repo_path": "integration/fx-team", 21:08:34 INFO - "revision": "ef9c1cc0a76ca05d459cda0a0d74266f5d916341", 21:08:34 INFO - "stage_platform": "linux64", 21:08:34 INFO - "builduid": "e22b5d514c594dfea2eb74cda23d211c", 21:08:34 INFO - "slavebuilddir": "test" 21:08:34 INFO - } 21:08:34 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:34 INFO - Running post-action listener: _resource_record_post_action 21:08:34 INFO - ##### 21:08:34 INFO - ##### Running download-and-extract step. 21:08:34 INFO - ##### 21:08:34 INFO - Running pre-action listener: _resource_record_pre_action 21:08:34 INFO - Running main action method: download_and_extract 21:08:34 INFO - mkdir: /builds/slave/test/build/tests 21:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:34 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:34 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:34 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:34 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:34 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:36 INFO - Downloaded 1361 bytes. 21:08:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:08:36 INFO - Using the following test package requirements: 21:08:36 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:08:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:08:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'jsshell-linux-x86_64.zip'], 21:08:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:08:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:08:36 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:08:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:08:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:08:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloaded 22285608 bytes. 21:08:38 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:38 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:39 INFO - Return code: 0 21:08:39 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: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:08:39 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:39 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:39 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:39 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:39 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:41 INFO - Downloaded 22285608 bytes. 21:08:41 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:41 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:43 INFO - Return code: 0 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:43 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:44 INFO - Downloaded 10840145 bytes. 21:08:44 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:44 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:44 INFO - Return code: 0 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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:08:44 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:50 INFO - Downloaded 54743100 bytes. 21:08:50 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:50 INFO - mkdir: /builds/slave/test/properties 21:08:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:08:50 INFO - Writing to file /builds/slave/test/properties/build_url 21:08:50 INFO - Contents: 21:08:50 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:50 INFO - Running post-action listener: _resource_record_post_action 21:08:50 INFO - Running post-action listener: set_extra_try_arguments 21:08:50 INFO - ##### 21:08:50 INFO - ##### Running populate-webroot step. 21:08:50 INFO - ##### 21:08:50 INFO - Running pre-action listener: _resource_record_pre_action 21:08:50 INFO - Running main action method: populate_webroot 21:08:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:08:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:08:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:08:50 INFO - '--tppagecycles', 21:08:50 INFO - '7'], 21:08:50 INFO - 'tests': ['tsvgm']}}, 21:08:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:08:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:08:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:08:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:08:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['damp', 'tps']}, 21:08:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'tests': ['damp', 'tps']}, 21:08:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['dromaeo_dom']}, 21:08:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:08:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['a11yr', 21:08:50 INFO - 'ts_paint', 21:08:50 INFO - 'tpaint', 21:08:50 INFO - 'sessionrestore', 21:08:50 INFO - 'sessionrestore_no_auto_restore', 21:08:50 INFO - 'tabpaint']}, 21:08:50 INFO - 'other-e10s': {'tests': ['a11yr', 21:08:50 INFO - 'ts_paint', 21:08:50 INFO - 'tpaint', 21:08:50 INFO - 'sessionrestore', 21:08:50 INFO - 'sessionrestore_no_auto_restore', 21:08:50 INFO - 'tabpaint']}, 21:08:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:08:50 INFO - 'ts_paint', 21:08:50 INFO - 'tpaint', 21:08:50 INFO - 'sessionrestore', 21:08:50 INFO - 'sessionrestore_no_auto_restore', 21:08:50 INFO - 'tabpaint']}, 21:08:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:08:50 INFO - 'ts_paint', 21:08:50 INFO - 'tpaint', 21:08:50 INFO - 'sessionrestore', 21:08:50 INFO - 'sessionrestore_no_auto_restore', 21:08:50 INFO - 'tabpaint']}, 21:08:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['a11yr', 21:08:50 INFO - 'ts_paint', 21:08:50 INFO - 'tpaint', 21:08:50 INFO - 'sessionrestore', 21:08:50 INFO - 'sessionrestore_no_auto_restore', 21:08:50 INFO - 'tabpaint']}, 21:08:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['a11yr', 21:08:50 INFO - 'ts_paint', 21:08:50 INFO - 'tpaint', 21:08:50 INFO - 'sessionrestore', 21:08:50 INFO - 'sessionrestore_no_auto_restore', 21:08:50 INFO - 'tabpaint']}, 21:08:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['tsvgx', 21:08:50 INFO - 'tsvgr_opacity', 21:08:50 INFO - 'tart', 21:08:50 INFO - 'tscrollx', 21:08:50 INFO - 'cart']}, 21:08:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:08:50 INFO - 'tsvgr_opacity', 21:08:50 INFO - 'tart', 21:08:50 INFO - 'tscrollx', 21:08:50 INFO - 'cart']}, 21:08:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'talos_options': ['--disable-e10s'], 21:08:50 INFO - 'tests': ['tp5o']}, 21:08:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'tests': ['tp5o']}, 21:08:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'talos_options': ['--disable-e10s', 21:08:50 INFO - '--xperf_path', 21:08:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:50 INFO - 'tests': ['tp5n']}, 21:08:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:50 INFO - 'talos_options': ['--xperf_path', 21:08:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:50 INFO - 'tests': ['tp5n']}}, 21:08:50 INFO - 'talos.zip': {'path': '', 21:08:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:08:50 INFO - Running post-action listener: _resource_record_post_action 21:08:50 INFO - ##### 21:08:50 INFO - ##### Running create-virtualenv step. 21:08:50 INFO - ##### 21:08:50 INFO - Running pre-action listener: _resource_record_pre_action 21:08:50 INFO - Running main action method: create_virtualenv 21:08:50 INFO - Creating virtualenv /builds/slave/test/build/venv 21:08:50 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:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:08:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:08:50 INFO - Using real prefix '/usr' 21:08:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:08:51 INFO - Installing distribute.............................................................................................................................................................................................done. 21:08:53 INFO - Installing pip.................done. 21:08:53 INFO - Return code: 0 21:08:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:53 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:08:53 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:08:53 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:08:53 INFO - Using env: {'DISPLAY': ':0', 21:08:53 INFO - 'HOME': '/home/cltbld', 21:08:53 INFO - 'LANG': 'en_US.UTF-8', 21:08:53 INFO - 'LANGUAGE': 'en_US:en', 21:08:53 INFO - 'LOGNAME': 'cltbld', 21:08:53 INFO - 'MAIL': '/var/mail/cltbld', 21:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:53 INFO - 'MOZ_NO_REMOTE': '1', 21:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:53 INFO - 'NO_EM_RESTART': '1', 21:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:53 INFO - 'PWD': '/builds/slave/test', 21:08:53 INFO - 'SHELL': '/bin/bash', 21:08:53 INFO - 'SHLVL': '1', 21:08:53 INFO - 'TERM': 'linux', 21:08:53 INFO - 'TMOUT': '86400', 21:08:53 INFO - 'USER': 'cltbld', 21:08:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:53 INFO - '_': '/tools/buildbot/bin/python'} 21:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:53 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:08:53 INFO - Cleaning up... 21:08:53 INFO - Return code: 0 21:08:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:53 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:08:53 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:08:53 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:08:53 INFO - Using env: {'DISPLAY': ':0', 21:08:53 INFO - 'HOME': '/home/cltbld', 21:08:53 INFO - 'LANG': 'en_US.UTF-8', 21:08:53 INFO - 'LANGUAGE': 'en_US:en', 21:08:53 INFO - 'LOGNAME': 'cltbld', 21:08:53 INFO - 'MAIL': '/var/mail/cltbld', 21:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:53 INFO - 'MOZ_NO_REMOTE': '1', 21:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:53 INFO - 'NO_EM_RESTART': '1', 21:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:53 INFO - 'PWD': '/builds/slave/test', 21:08:53 INFO - 'SHELL': '/bin/bash', 21:08:53 INFO - 'SHLVL': '1', 21:08:53 INFO - 'TERM': 'linux', 21:08:53 INFO - 'TMOUT': '86400', 21:08:53 INFO - 'USER': 'cltbld', 21:08:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:53 INFO - '_': '/tools/buildbot/bin/python'} 21:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:53 INFO - Downloading/unpacking psutil>=0.7.1 21:08:53 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:08:53 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:08:53 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:08:53 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:08:53 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:08:53 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:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:55 INFO - Installing collected packages: psutil 21:08:55 INFO - Running setup.py install for psutil 21:08:55 INFO - building 'psutil._psutil_linux' extension 21:08:55 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:08:56 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:08:56 INFO - building 'psutil._psutil_posix' extension 21:08:56 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:08:56 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:08:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:08:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:08:56 INFO - Successfully installed psutil 21:08:56 INFO - Cleaning up... 21:08:56 INFO - Return code: 0 21:08:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:08:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:56 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:08:56 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:08:56 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:08:56 INFO - Using env: {'DISPLAY': ':0', 21:08:56 INFO - 'HOME': '/home/cltbld', 21:08:56 INFO - 'LANG': 'en_US.UTF-8', 21:08:56 INFO - 'LANGUAGE': 'en_US:en', 21:08:56 INFO - 'LOGNAME': 'cltbld', 21:08:56 INFO - 'MAIL': '/var/mail/cltbld', 21:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:56 INFO - 'MOZ_NO_REMOTE': '1', 21:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:56 INFO - 'NO_EM_RESTART': '1', 21:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:56 INFO - 'PWD': '/builds/slave/test', 21:08:56 INFO - 'SHELL': '/bin/bash', 21:08:56 INFO - 'SHLVL': '1', 21:08:56 INFO - 'TERM': 'linux', 21:08:56 INFO - 'TMOUT': '86400', 21:08:56 INFO - 'USER': 'cltbld', 21:08:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:56 INFO - '_': '/tools/buildbot/bin/python'} 21:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:08:58 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:08:58 INFO - Installing collected packages: mozsystemmonitor 21:08:58 INFO - Running setup.py install for mozsystemmonitor 21:08:58 INFO - Successfully installed mozsystemmonitor 21:08:58 INFO - Cleaning up... 21:08:58 INFO - Return code: 0 21:08:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:08:58 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:08:58 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:08:58 INFO - Using env: {'DISPLAY': ':0', 21:08:58 INFO - 'HOME': '/home/cltbld', 21:08:58 INFO - 'LANG': 'en_US.UTF-8', 21:08:58 INFO - 'LANGUAGE': 'en_US:en', 21:08:58 INFO - 'LOGNAME': 'cltbld', 21:08:58 INFO - 'MAIL': '/var/mail/cltbld', 21:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:58 INFO - 'MOZ_NO_REMOTE': '1', 21:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:58 INFO - 'NO_EM_RESTART': '1', 21:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:58 INFO - 'PWD': '/builds/slave/test', 21:08:58 INFO - 'SHELL': '/bin/bash', 21:08:58 INFO - 'SHLVL': '1', 21:08:58 INFO - 'TERM': 'linux', 21:08:58 INFO - 'TMOUT': '86400', 21:08:58 INFO - 'USER': 'cltbld', 21:08:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:58 INFO - '_': '/tools/buildbot/bin/python'} 21:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:08:58 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:08:58 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:08:58 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:08:58 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:08:58 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:08:58 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:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:01 INFO - Downloading docopt-0.6.1.tar.gz 21:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:01 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:01 INFO - Running setup.py install for blobuploader 21:09:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:01 INFO - Running setup.py install for requests 21:09:02 INFO - Running setup.py install for docopt 21:09:02 INFO - Successfully installed blobuploader requests docopt 21:09:02 INFO - Cleaning up... 21:09:02 INFO - Return code: 0 21:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:02 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 21:09:02 INFO - 'HOME': '/home/cltbld', 21:09:02 INFO - 'LANG': 'en_US.UTF-8', 21:09:02 INFO - 'LANGUAGE': 'en_US:en', 21:09:02 INFO - 'LOGNAME': 'cltbld', 21:09:02 INFO - 'MAIL': '/var/mail/cltbld', 21:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:02 INFO - 'MOZ_NO_REMOTE': '1', 21:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:02 INFO - 'NO_EM_RESTART': '1', 21:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:02 INFO - 'PWD': '/builds/slave/test', 21:09:02 INFO - 'SHELL': '/bin/bash', 21:09:02 INFO - 'SHLVL': '1', 21:09:02 INFO - 'TERM': 'linux', 21:09:02 INFO - 'TMOUT': '86400', 21:09:02 INFO - 'USER': 'cltbld', 21:09:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:02 INFO - '_': '/tools/buildbot/bin/python'} 21:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:02 INFO - Running setup.py (path:/tmp/pip-_rDlYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:02 INFO - Running setup.py (path:/tmp/pip-6LC4CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:02 INFO - Running setup.py (path:/tmp/pip-UvsNkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:02 INFO - Running setup.py (path:/tmp/pip-3cdoXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:02 INFO - Running setup.py (path:/tmp/pip-p2HYgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:02 INFO - Running setup.py (path:/tmp/pip-QkOp4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:02 INFO - Running setup.py (path:/tmp/pip-PVOXdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:02 INFO - Running setup.py (path:/tmp/pip-RjS87g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:02 INFO - Running setup.py (path:/tmp/pip-9yosAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:03 INFO - Running setup.py (path:/tmp/pip-5COg9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:03 INFO - Running setup.py (path:/tmp/pip-cBXj_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:03 INFO - Running setup.py (path:/tmp/pip-tni5iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:03 INFO - Running setup.py (path:/tmp/pip-GnsJdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:03 INFO - Running setup.py (path:/tmp/pip-jp3jZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:03 INFO - Running setup.py (path:/tmp/pip-RrYtJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:03 INFO - Running setup.py (path:/tmp/pip-K89W7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:03 INFO - Running setup.py (path:/tmp/pip-YspjA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:03 INFO - Running setup.py install for manifestparser 21:09:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:03 INFO - Running setup.py install for mozcrash 21:09:03 INFO - Running setup.py install for mozdebug 21:09:03 INFO - Running setup.py install for mozdevice 21:09:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for mozfile 21:09:04 INFO - Running setup.py install for mozhttpd 21:09:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for mozinfo 21:09:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for mozInstall 21:09:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for mozleak 21:09:04 INFO - Running setup.py install for mozlog 21:09:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for moznetwork 21:09:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for mozprocess 21:09:04 INFO - Running setup.py install for mozprofile 21:09:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:04 INFO - Running setup.py install for mozrunner 21:09:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:05 INFO - Running setup.py install for mozscreenshot 21:09:05 INFO - Running setup.py install for moztest 21:09:05 INFO - Running setup.py install for mozversion 21:09:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:05 INFO - Cleaning up... 21:09:05 INFO - Return code: 0 21:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:05 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 21:09:05 INFO - 'HOME': '/home/cltbld', 21:09:05 INFO - 'LANG': 'en_US.UTF-8', 21:09:05 INFO - 'LANGUAGE': 'en_US:en', 21:09:05 INFO - 'LOGNAME': 'cltbld', 21:09:05 INFO - 'MAIL': '/var/mail/cltbld', 21:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:05 INFO - 'MOZ_NO_REMOTE': '1', 21:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:05 INFO - 'NO_EM_RESTART': '1', 21:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:05 INFO - 'PWD': '/builds/slave/test', 21:09:05 INFO - 'SHELL': '/bin/bash', 21:09:05 INFO - 'SHLVL': '1', 21:09:05 INFO - 'TERM': 'linux', 21:09:05 INFO - 'TMOUT': '86400', 21:09:05 INFO - 'USER': 'cltbld', 21:09:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:05 INFO - '_': '/tools/buildbot/bin/python'} 21:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:05 INFO - Running setup.py (path:/tmp/pip-Z4BOPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:05 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:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:05 INFO - Running setup.py (path:/tmp/pip-CAAogn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:05 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:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:05 INFO - Running setup.py (path:/tmp/pip-w36WI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:05 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:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:05 INFO - Running setup.py (path:/tmp/pip-0hDdko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:05 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:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:05 INFO - Running setup.py (path:/tmp/pip-oiPoUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:06 INFO - Running setup.py (path:/tmp/pip-5jJ3q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:06 INFO - Running setup.py (path:/tmp/pip-RTsebY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:06 INFO - Running setup.py (path:/tmp/pip-Ap4XHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:06 INFO - Running setup.py (path:/tmp/pip-bG6TKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:06 INFO - Running setup.py (path:/tmp/pip-_B7Ux6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:06 INFO - Running setup.py (path:/tmp/pip-KOTEoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:06 INFO - Running setup.py (path:/tmp/pip-5wtztH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:06 INFO - Running setup.py (path:/tmp/pip-06eZ6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:06 INFO - Running setup.py (path:/tmp/pip-tYQigu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:06 INFO - Running setup.py (path:/tmp/pip-ujluGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:06 INFO - Running setup.py (path:/tmp/pip-UfdJFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:06 INFO - Running setup.py (path:/tmp/pip-kKbCQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 21:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:08 INFO - Installing collected packages: blessings 21:09:08 INFO - Running setup.py install for blessings 21:09:08 INFO - Successfully installed blessings 21:09:08 INFO - Cleaning up... 21:09:08 INFO - Return code: 0 21:09:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:09 INFO - Reading from file tmpfile_stdout 21:09:09 INFO - Current package versions: 21:09:09 INFO - argparse == 1.2.1 21:09:09 INFO - blessings == 1.6 21:09:09 INFO - blobuploader == 1.2.4 21:09:09 INFO - docopt == 0.6.1 21:09:09 INFO - manifestparser == 1.1 21:09:09 INFO - mozInstall == 1.12 21:09:09 INFO - mozcrash == 0.17 21:09:09 INFO - mozdebug == 0.1 21:09:09 INFO - mozdevice == 0.48 21:09:09 INFO - mozfile == 1.2 21:09:09 INFO - mozhttpd == 0.7 21:09:09 INFO - mozinfo == 0.9 21:09:09 INFO - mozleak == 0.1 21:09:09 INFO - mozlog == 3.1 21:09:09 INFO - moznetwork == 0.27 21:09:09 INFO - mozprocess == 0.22 21:09:09 INFO - mozprofile == 0.28 21:09:09 INFO - mozrunner == 6.11 21:09:09 INFO - mozscreenshot == 0.1 21:09:09 INFO - mozsystemmonitor == 0.0 21:09:09 INFO - moztest == 0.7 21:09:09 INFO - mozversion == 1.4 21:09:09 INFO - psutil == 3.1.1 21:09:09 INFO - requests == 1.2.3 21:09:09 INFO - wsgiref == 0.1.2 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', '--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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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', '--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:09 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: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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 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 - 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Cleaning up... 21:09:09 INFO - Return code: 0 21:09:09 INFO - Installing jsonschema 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', '--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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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', '--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:09 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: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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 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 - Downloading/unpacking jsonschema 21:09:09 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:09 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:09 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:09 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:09 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:09 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:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:09:11 INFO - Downloading/unpacking functools32 (from jsonschema) 21:09:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Downloading functools32-3.2.3-2.tar.gz 21:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:09:11 INFO - warning: no files found matching '*.txt' 21:09:11 INFO - no previously-included directories found matching 'build' 21:09:11 INFO - no previously-included directories found matching 'dist' 21:09:11 INFO - no previously-included directories found matching '.git*' 21:09:11 INFO - Installing collected packages: jsonschema, functools32 21:09:11 INFO - Running setup.py install for functools32 21:09:11 INFO - warning: no files found matching '*.txt' 21:09:11 INFO - no previously-included directories found matching 'build' 21:09:11 INFO - no previously-included directories found matching 'dist' 21:09:11 INFO - no previously-included directories found matching '.git*' 21:09:11 INFO - Successfully installed jsonschema functools32 21:09:11 INFO - Cleaning up... 21:09:11 INFO - Return code: 0 21:09:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:09:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:11 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 0x7f22a40a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 21:09:11 INFO - 'HOME': '/home/cltbld', 21:09:11 INFO - 'LANG': 'en_US.UTF-8', 21:09:11 INFO - 'LANGUAGE': 'en_US:en', 21:09:11 INFO - 'LOGNAME': 'cltbld', 21:09:11 INFO - 'MAIL': '/var/mail/cltbld', 21:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:11 INFO - 'MOZ_NO_REMOTE': '1', 21:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:11 INFO - 'NO_EM_RESTART': '1', 21:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:11 INFO - 'PWD': '/builds/slave/test', 21:09:11 INFO - 'SHELL': '/bin/bash', 21:09:11 INFO - 'SHLVL': '1', 21:09:11 INFO - 'TERM': 'linux', 21:09:11 INFO - 'TMOUT': '86400', 21:09:11 INFO - 'USER': 'cltbld', 21:09:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:11 INFO - '_': '/tools/buildbot/bin/python'} 21:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:12 INFO - Downloading/unpacking flake8 21:09:12 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:12 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:12 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:12 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:12 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:12 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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:09:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:09:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:09:14 INFO - no previously-included directories found matching 'docs/_build' 21:09:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:09:14 INFO - Running setup.py install for pep8 21:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:09:14 INFO - no previously-included directories found matching 'docs/_build' 21:09:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:09:14 INFO - Cleaning up... 21:09:15 INFO - Return code: 0 21:09:15 INFO - Running post-action listener: _resource_record_post_action 21:09:15 INFO - Running post-action listener: _start_resource_monitoring 21:09:15 INFO - Starting resource monitoring. 21:09:15 INFO - ##### 21:09:15 INFO - ##### Running install step. 21:09:15 INFO - ##### 21:09:15 INFO - Running pre-action listener: _resource_record_pre_action 21:09:15 INFO - Running main action method: install 21:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:15 INFO - Reading from file tmpfile_stdout 21:09:15 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:15 INFO - Reading from file tmpfile_stdout 21:09:15 INFO - Output received: 21:09:15 INFO - Usage: mozinstall [options] installer 21:09:15 INFO - Options: 21:09:15 INFO - -h, --help show this help message and exit 21:09:15 INFO - -d DEST, --destination=DEST 21:09:15 INFO - Directory to install application into. [default: 21:09:15 INFO - "/builds/slave/test"] 21:09:15 INFO - --app=APP Application being installed. [default: firefox] 21:09:15 INFO - mkdir: /builds/slave/test/build/application 21:09:15 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:15 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:31 INFO - Reading from file tmpfile_stdout 21:09:31 INFO - Output received: 21:09:31 INFO - /builds/slave/test/build/application/firefox/firefox 21:09:31 INFO - Running post-action listener: _resource_record_post_action 21:09:31 INFO - ##### 21:09:31 INFO - ##### Running run-tests step. 21:09:31 INFO - ##### 21:09:31 INFO - Running pre-action listener: _resource_record_pre_action 21:09:31 INFO - Running main action method: run_tests 21:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:31 INFO - Python 2.7.3 21:09:31 INFO - Return code: 0 21:09:31 INFO - grabbing minidump binary from tooltool 21:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:31 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 0x232d410>, '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 0x232e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x232e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09:31 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:31 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:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:31 INFO - Return code: 0 21:09:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:09:32 INFO - Return code: 0 21:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:09:32 INFO - Using env: {'DISPLAY': ':0', 21:09:32 INFO - 'HOME': '/home/cltbld', 21:09:32 INFO - 'LANG': 'en_US.UTF-8', 21:09:32 INFO - 'LANGUAGE': 'en_US:en', 21:09:32 INFO - 'LOGNAME': 'cltbld', 21:09:32 INFO - 'MAIL': '/var/mail/cltbld', 21:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:32 INFO - 'MOZ_NO_REMOTE': '1', 21:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:32 INFO - 'NO_EM_RESTART': '1', 21:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:32 INFO - 'PWD': '/builds/slave/test', 21:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:32 INFO - 'SHELL': '/bin/bash', 21:09:32 INFO - 'SHLVL': '1', 21:09:32 INFO - 'TERM': 'linux', 21:09:32 INFO - 'TMOUT': '86400', 21:09:32 INFO - 'USER': 'cltbld', 21:09:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457', 21:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:32 INFO - '_': '/tools/buildbot/bin/python'} 21:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bS5hA466SPiVaQc5B_yuoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:09:32 INFO - mozversion application_buildid: 20160423200647 21:09:32 INFO - mozversion application_changeset: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 21:09:32 INFO - mozversion application_display_name: Nightly 21:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:32 INFO - mozversion application_name: Firefox 21:09:32 INFO - mozversion application_remotingname: firefox 21:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:09:32 INFO - mozversion application_vendor: Mozilla 21:09:32 INFO - mozversion application_version: 48.0a1 21:09:32 INFO - mozversion platform_buildid: 20160423200647 21:09:32 INFO - mozversion platform_changeset: ef9c1cc0a76ca05d459cda0a0d74266f5d916341 21:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:09:32 INFO - mozversion platform_version: 48.0a1 21:09:32 INFO - using testdate: 1461470972 21:09:32 INFO - actual date: 1461470972 21:09:32 INFO - starting webserver on 'localhost:47682' 21:09:32 INFO - SUITE-START | Running 2 tests 21:09:32 INFO - TEST-START | dromaeo_css 21:09:32 INFO - operating with platform_type : linux_ 21:09:32 INFO - Initialising browser for dromaeo_css test... 21:09:32 INFO - TEST-INFO | started process 3298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPpg4DG/profile http://localhost:47682/getInfo.html) 21:09:36 INFO - PROCESS | 3298 | __metrics Screen width/height:1600/1200 21:09:36 INFO - PROCESS | 3298 | colorDepth:24 21:09:36 INFO - PROCESS | 3298 | Browser inner width/height: 1024/697 21:09:36 INFO - PROCESS | 3298 | __metrics 21:09:37 ERROR - PROCESS | 3298 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:09:38 INFO - TEST-INFO | 3298: exit 0 21:09:38 INFO - Browser initialized. 21:09:38 INFO - Running cycle 1/1 for dromaeo_css test... 21:09:38 INFO - TEST-INFO | started process 3377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPpg4DG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:09:50 INFO - PROCESS | 3377 | RSS: Main: 155967488 21:09:50 INFO - PROCESS | 3377 | 21:10:41 INFO - PROCESS | 3377 | 1461471041152 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:12:53 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47682/tests/dromaeo/cssquery-ext.html) 21:12:54 INFO - PROCESS | 3377 | RSS: Main: 238067712 21:12:54 INFO - PROCESS | 3377 | 21:15:56 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-ext.html (next: http://localhost:47682/tests/dromaeo/cssquery-jquery.html) 21:15:57 INFO - PROCESS | 3377 | RSS: Main: 238370816 21:15:57 INFO - PROCESS | 3377 | 21:18:59 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47682/tests/dromaeo/cssquery-mootools.html) 21:18:59 INFO - PROCESS | 3377 | RSS: Main: 232452096 21:18:59 INFO - PROCESS | 3377 | 21:22:02 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47682/tests/dromaeo/cssquery-prototype.html) 21:22:02 INFO - PROCESS | 3377 | RSS: Main: 232759296 21:22:02 INFO - PROCESS | 3377 | 21:25:05 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47682/tests/dromaeo/cssquery-yui.html) 21:25:06 INFO - PROCESS | 3377 | RSS: Main: 223240192 21:25:06 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:47682/tests/dromaeo/cssquery-yui.html (next: http://localhost:47682/tests/dromaeo/cssquery-dojo.html) 21:28:09 INFO - PROCESS | 3377 | RSS: Main: 273674240 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | __start_tp_report 21:28:09 INFO - PROCESS | 3377 | _x_x_mozilla_page_load 21:28:09 INFO - PROCESS | 3377 | _x_x_mozilla_page_load_details 21:28:09 INFO - PROCESS | 3377 | |i|pagename|runs| 21:28:09 INFO - PROCESS | 3377 | |0;dojo.html;2600.59690747934;2679.0623281851367;2681.5709486482165;2682.517146913555;2696.1641891013787;4557.544245575441;4625.537446255373;4682.601978831799;4684.391029166208;4693.249080147173;4648.442186937572;4682.742449165295;4777.259524773657;4816.470188279286;4820.180569303218;4296.140771845636;4338.566143385668;4361.3676016977515;4408.42690450241;4436.423264975549;4321.373400856874;4375.4311939447825;4421.624161946238;4454.777261136946;4455.866324010269;4247.447831781879;4325.286327755916;4378.474583050022;4423.336499525097;4425.380446737459;4273.722208056497;4292.678049146295;4310.762908040057;4313.568643135693;4316.892077698051;4204.8528301509605;4253.319468884994;4262.957370426287;4268.317069268902;4368.213721530124;4608.493065762764;4608.861734147948;4613.192691279013;4619.838305659319;4644.349791029259;5038.193888977783;5041.395032596112;5051.898962020739;5097.23541468779;5117.002184574009;4925.458199598042;5059.139946209153;5104.64267501275;5173.58611311098;5180.533751962342;4693.389859318267;4723.315119307681;4725.149473094807;4725.834595789131;4727.432708075053;5159.819406320761;5173.560247379015;5174.43081261061;5179.352580927384;5230.476952304739;4799.760011999386;4882.926756098661;4945.752712364368;4977.0792403405485;4998.650094493423;5001.124803159505;5016.598672106223;5017.347744793154;5049.293098966147;5073.670211436245;4858.416989961227;5016.799328026911;5017.197248440232;5021.974890125526;5047.621428392885;4906.411230652345;4928.112939670894;5020.347354843847;5030.974845125751;5037.798488060436;4314.80583373749;4339.674524410619;4340.587644173798;4340.76125813077;4384.0355121873135;3778.8677396290996;3794.8102594870147;3797.4493698413576;3803.125281185343;3823.4647149399107;4195.916081678411;4299.441072660597;4350.129974005212;4391.165678521071;4393.165298593257;4994.175960966472;4995.425526064477;5029;5031.52200540948;5074.162763144113;4229.97885010573;4296.2696341621995;4303.117860838521;4309.245881970705;4345.022369966732;4524.09518096382;4591.311303304531;4592.977035114803;4631.467381251199;4638.698484598491;4672.906541869143;4684.437867455791;4687.718736875799;4689.202835518038;4710.552497512731;4908.092002979461;4943;4972.477889821516;4982.4768399317545;5027.497250274943;4720.504347043511;4757;4761.190597598347;4768.427788665383;4813.061453016629;4971.825986090469;4975.154223782039;4975.925361119514;4979.228219625964;5026.974865125651;4858.684185527929;4945.530174633404;5052.898942021213;5076.7207803571155;5091.66904151229;4880.072786170616;4903.95096049035;4907.460179380194;4935.062338155739;4945.826896058621;4894.92657610129;4912.38595175603;4912.852614421573;4923.556879880828;4923.848522994716;4659.534046595313;4710.528947105262;4757.476677565396;4841.806327746851;4891.144049791344;4780.665353425227;4829.227323628203;4831.96112835742;4847.079054979543;4851.223804191312;4803.903921921472;4861.149298872754;4861.368022157097;4871.391076115486;4908.7300198488 21:28:09 INFO - PROCESS | 3377 | |1;ext.html;584.1704779213517;595.1370512756503;600.78371786157;616.7224748863013;641.5605310362399;27767.444651106965;34724.82637586811;35745.285094298095;35875.64124358755;35934.2813143737;37364.43953340702;38115.237695246076;38125;38201.42697859527;38243.61756382435;7272.63636818157;7592.20281870404;7774.961125194366;7776.65005074773;9566.330356875022;9750.951245243763;9899.15857152143;9903.653372131941;9906.801863962717;9909.653162139326;9837.311388202828;9951.004899510064;9953.800923981516;9960.900390996107;9962.053604907558;9822.410655360665;9892.55483503237;9909.355891867006;9915.652952146713;9919.057689519484;9686.15962967034;10073.748156296078;10074.597016119347;10081.747956301078;10089.848652270222;37985.24029519422;38275.425868611994;38415.61584384176;38668.226635467414;38687.806560967016;3239.2549713566013;3277.7705560610766;3339.9499007514905;3403.23427228874;3494.5457090578316;29045;29364.972225972204;29482.262943426373;29483.557746633818;29680.70319296801;3527.2592755521373;3595.352836489431;3605.6214097519905;3605.855765769366;3679.558452985632;234774;238321;238619.80690096613;239486;239794;53781.50420222673;54460.72769636206;54608.180877286875;54717.452825472035;54725.72637136789;58013.41986580165;58265.70867145637;58549.70725146347;58644;58645.413545863994;14184.929075354763;14308;14359.85640143606;14393.92803035978;14414.495492657916;9139.77150571241;10294.897051029544;10596.417197054081;10727.409992450333;10754.247202695893;16614.086225257484;16679;16801.24394402255;16980;17094.91452542729;6024.367441418588;6110.175126357974;6117.816465505953;6337.271213810379;6397.264314603787;953.5899563187896;970.6311601591491;987.8814542254831;992.5682328187262;1036.2953191829477;28041.57937630937;28165.295867603472;28745.56881646777;28757.28106797347;28814.71185288162;992.925530585209;1033.4987531047436;1054.699410667956;1074.957001719938;1098.7912296663608;14864.777028344584;15019.624509387135;15215.109129265404;15265.06355032832;15307.846921530641;333818;337126;340162;340225;341839;49414.25878611824;50003.749981249865;50044.249336259985;50092;50107;1127.3236058364917;1177.4112943528237;1196.976060478803;1202.8255902893857;1289.4777615065914;24391.390215244763;25577.360565986;26112.8694356527;26117.477650447265;26755.33111672224;33996;34376;34413.483797742556;34418.48372274368;34473.482897756054;225617;230566;230890;231112;231407;32027;34507.13732156716;38609;40070.398944016444;42544.1491170181;40832;41063.1787364257;41114.38328425136;41860.79069604632;42091.7895410521;34236.31527369389;34589.48115778215;35111.12222194466;35141.82429087838;35243.647563524035;34793.130171744895;35012;35120;35432.82283588566;35440.11399715028;31327;31463.52804707977;31484.2128946769;33822;35092.64907350894;30069.54895676523;31553.368932621677;31719.365612688078;32086.67913320837;32088;23910.28269151928;24453;24547.509049819262;24874.626880596443;24888.875555622108 21:28:09 INFO - PROCESS | 3377 | |2;jquery.html;369.21910160011566;371.17413754396455;374.16187739463595;382.59444988312407;388.37471670610313;16124.19379031048;16434.93172943758;16710;16723.49829505115;16746.16269186542;15544;15598.84401155988;17435.041072740994;17463.476095717117;17472.737908931344;5091.974540127294;5244.160934250521;5273.314469119009;5276.34045744282;5281.947180528184;3776.169242766587;3973.9006524836964;5246.632735708502;5723.971380143114;6062.999605065181;5955.076963070731;6017.789377371793;6029.728662210189;6037.184980027684;6041.063635136539;5895.823125306248;6010.549208809357;6017.007193813038;6020.2775666919815;6024.2770867495965;3355.697987181141;5000.524950129732;5153.072446959546;5293.258943747878;5300.549453296474;19341.709874351895;19497.707534386995;19627.803721962882;20490.692639610417;21253.256136035165;1886.6038131992298;1903.6097599992106;1970.3990282963691;2067.7105205271273;2504.8246622736415;13064.412101455457;13075.476980920752;13111.541096061592;13141.27722975236;13593;1722.8277172282797;1737.6959032169445;1775.2632657447143;1826.6620675175136;1836.898970556619;66919;68806;69265.65367173131;69590.65204673995;70117.29882701159;9176.265898728087;9201.95399023014;9268.629254829866;9545.761355966157;9666.178374838217;12629.557965471164;12692.42884070219;12733.872661273454;12764.80852787209;12831.550895718792;6869.347411995853;6896.655137253358;6938.791836244921;7047.43620510358;7098.574085554883;6608.43828274602;6626.867462650816;6736.393724564813;6749.898751518731;6759.966200168968;6026.337102918676;6094.360092190256;6096.695165241809;6143.477804386677;6145.877082458326;1559.8518140776607;1598.696247712931;1676.8910020848605;1800.8109148539215;1808.52074200337;882.6557642519423;930.2232635749225;941.7080704981478;983.3706427886159;990.4305024610877;16417.507474775775;16515.256813443422;16534;16691.666166676598;16894.40869569559;884.951327676984;903.8056817784208;923.7182659288982;937.7280588629221;940.0634990037889;9988.652666623339;10096.747581310527;10111.848322275171;10119.59521619127;10121.848172277421;138477;389897;397797;410085;421293;77168;81928.59035704784;84054.5797271022;84368;84495.57752211322;970.815545046439;973.3089506450499;991.6578780320777;991.667791289926;1003.9799204015878;15225.238738062832;15545.455909043128;15735.527934161993;15935.840641593899;16233.269502872163;31992.200194995312;36326.27347452983;36795.81602092079;37198.29200689125;37593.81203093967;46135.53864461447;51510;51514.48485515097;51525.227121593955;51666.483335166165;7524.962375188089;7683.423743219393;7721.961390193013;7781.494202876795;7833.921660783547;10720.19598530129;11764.647060588197;11828.76342473163;11873.470587942184;12353.629391117922;9677.129058384779;9766.804663906823;9986.650467233612;10179.592816287266;10256.12822910061;9759.951200243953;9921.751956201153;10287.53706083243;10319;10343.844842327522;10948.56205751793;11067.169962253025;11088.390138542458;11132.998030177323;11167.553297867995;7769.339606133542;7838.764837054898;7858.292753652198;7893.447458677838;7981.321587665114;8142.633581488729;9918.603255869684;10536.78926421452;10561.471926403496;10636.84044739314 21:28:09 INFO - PROCESS | 3377 | |3;mootools.html;1279.079063074586;1409.3235247081398;1460.8247010358757;1558.5402306319634;1733.4106403822698;6829.6243706596115;7577.242275772427;7813.218678132198;7824.021997250344;7830.216978302174;7559.69761209551;7716.151223365426;7721;7722.65248063837;7731.420143489247;1875.9155837987255;1941.708743688444;1944.6499630066583;2184.737831460227;2208.6686996950425;2136.6260904341757;2242.831787615927;2243.798058174764;2244.652078927769;2248.392933907844;2145.4529095080734;2146.291723731165;2160.2331172433796;2162.4810045589024;2217.979729324513;1849.657813304543;2114.8625339352893;2207.569523942832;2221.9223676516876;2224.4661281292533;2211.4139752965475;2233.6649502574583;2234.0505285253703;2236.731592208945;2240.047979608676;7624.504407213513;7658.119316278644;7670.5397676139055;7674.654640541189;7684.154742978268;4481.6638752093395;4622.537746225385;4629.305604159369;4637.234856248715;4639.164950308943;2975.1669532530927;3167.303193297471;3172.888948886801;3177.4280629486684;3189.8086114832954;972.1736523954653;977.8826540815077;981.7103954333418;992.0872797026752;1014.4319181258519;10715.357078575233;10742;10750.354978701303;10773.4613269337;10793.730156746065;4251.44731184944;4313.547077556874;4473.46318441789;4490.057088011489;4509.436320459942;9080.727578172666;9175.403598766059;9186.26509879208;9197.678081267124;9202.677906273382;4848.612111031109;4855.344528488608;4859.489753575824;4861.9027619447415;4863.489333619989;3790.6019867914024;3905.668018218483;4325.2214601371425;4408.845690400821;4438.60052595268;3705.203381273039;3786.7917264550165;3882.941755873664;3884.5532763731967;3889.4943657324366;1225.5036710132233;1259.1060347153623;1261.2999785119164;1266.1896386312767;1266.892314153289;722.6747963416484;889.3107841422819;902.4720538484928;911.981760364789;923.2706162131841;5426.430224826416;5450.5367043800925;5607.355154157242;5642.069058605366;5644.125160600113;413.3737387857398;413.6876658123098;418.2972606021912;423.8558889977422;424.448217317486;3729.3846515324667;3804.505414296124;3821.082940094413;3837.9040523986564;3990.900227494336;9429.76425589352;9734.318597698093;9740.707778766648;9828.361156524803;9835.557399917021;9524.095210954949;9638.518074096268;9691.854622180674;9700.514974251259;9711.417314960983;7257.818554536178;7395.7041718330665;7424.925750742424;7464.552126872297;7507.249275072449;5232.241325007929;5545.972270138624;5626.24045753818;5658.830235092953;5690.2887139107615;8553;8795;8827;8877.378583499092;8972.685955991508;8751.562421879007;8929.883764529433;8937.195652391316;9299.535023248945;9358.953205234202;6338.334474880071;6679.6994135265;6898.275681053417;6922.723091076301;6951.513394062367;7452.739154129579;7491;7528.8494230116185;7565.167831538416;7567.735129270449;6629.668516574248;6863.725450982104;6906.965465172642;6961.651917404009;7012.368886800213;6699.631520266432;6708.664566771739;6750.459963202834;6786;6791;6305.148804911279;6308.747650093945;6346.873062538631;6364.840878978062;6420.6468644225015;4857.854264372075;4893.388326459192;5012.899742005066;5020.723860187724;5097.209932460474;4822.71063736177;4847.079054979543;4891.5353041461;4895.804167833389;4920.40955085392 21:28:09 INFO - PROCESS | 3377 | |4;prototype.html;303.4098678071151;307.6830864209864;312.7482376686768;318.56356791196066;319.4696803306509;4913.459519452857;5040.495950404967;5081.187010078388;5145.691258524491;5191.688498690081;4930.285108659242;5081.1108056090125;5098.923516147252;5114.079465696173;5119.336215729893;3991;4015.799210039501;4018.859339923103;4022.235775202702;4044.9191016179657;3809.9238015239816;3837.884863454101;4000.159966407058;4040.919181616366;4054.939175912349;3953.0907891185043;3956.861509847156;3973.562908080109;3974.5230572331216;4005.218982298453;3938.8818335449982;3953.8220780064967;3955.8219880105466;3972.920541589181;3974.125692347679;3412.146963259185;3511.9297614047578;3518.665726755954;3528.4883691864534;3535.5403797506415;4849.248366503198;4857.34425852509;4862.586680132193;4886.120498310338;4902.7058376497525;4576.54234576543;4582.358469814229;4584.931226031612;4591;4595.2188128018315;5255.211718242256;5351.7324133793545;5380.677159370412;5381.381141168777;5396.163594642798;3849.903752406184;3860.7297489175767;3866.3040652682507;3870.4774855394444;3874.4575759393706;5618.4662457066515;5648.096304591246;5648.491635752802;5653.519450846683;5673.687947162863;3962.346212874901;3965.643092121723;3967.821448034845;3970.722049456568;3972.503437070366;3677.1542545214215;3888.922221555553;3908.5700572936953;3928.958825911136;4029.516458024997;4472.44094488189;4493.977710030499;4496.235639941217;4500.617447516932;4505.324201369821;5354.464553544614;5393.7033463159905;5398.460153984649;5411.918821217685;5417.4808713948205;1245.2341809786915;1279.705667696435;1348.1169833758904;1349.878510934001;1351.6215459671307;891.790429249126;895.4492986813063;918.7749001494676;920.8526635738384;927.3091546797679;4595.264757638762;4631.884202894955;4644.930326045112;4653.325267836145;4653.488116307203;5460.290162278879;5477.75350109246;5479.2602998594675;5480.479354461319;5484.780608775684;4511.751853648016;4588.609968152745;4635.605973492224;4638.1187574360765;4657.441107067174;2912.956305655417;2925.8683359248885;2929.7949143559745;2930.17954972608;2933.12006398084;5129.127868328033;5134.358205224347;5142.665726727751;5148.639595228298;5170.560502357342;5471.316085489314;5578;5586.888262234733;5614.9438505615235;5746.454086861741;5241.790328386822;5250.343707036621;5254.605904557174;5258.97370513145;5263.131583288791;5571.331440227036;5585.525230355465;5593.8321850344555;5594.832155035356;5610.158476228598;5293.100172970681;5475.001624406983;5489.890202196014;5524.696141712245;5534.418886016911;5237.4238833727495;5239.240310155083;5256.132738098324;5260.631755777059;5271.367435907716;3885.8834234972996;3933.7443066200603;3938.2714197873483;3942.3298039333954;3944.2308749793515;5190.429052804264;5278.366596008504;5588.105903055492;5592.86017849557;5598.3282006159525;5402.568844020285;5408.917566736756;5410.350757908918;5412.350517937873;5420.674759514442;5420.972895135499;5426.484483974016;5430.9185362218805;5443.237946687546;5451.454854514517;5043.873903152304;5264.341957255343;5299;5359.544438722753;5361.705106219196;5385.976664433745;5421.457854214547;5459.535939445032;5474.7810087597645;5476.151196564539;5169.431362550041;5294.126469132704;5299.7615107321035;5320.600954928318;5322.840314790563 21:28:09 INFO - PROCESS | 3377 | |5;yui.html;702.6627218934914;755.7203834581204;774.856651519469;786.2255678157014;807.192807192807;12503.687407814798;12969.221846689194;13163.47346106157;13168.802467962989;13169.473221071146;12873.291968941705;13557.457701691945;13695.863041369583;13708.794368084462;13709.725805483884;646.8609249011462;793.4168386236112;827.4704189318826;829.4857188543111;834.1950018232404;816.9714060007901;823.1398188892591;824.1675907333577;824.4640983360804;825.0182283083142;851.4082712514804;860.0797147052656;860.2300940658107;860.42781550269;862.3747782857441;669.4142625202948;836.9788857593726;858.0175698824842;858.0861382627481;868.9913100868973;627.1251604012423;627.9686015699197;628.346519619595;629.9401556852092;630.1713247080121;12965.805512917314;12973.286469244187;12994.090413671047;12999.285039322833;13011.21932684042;11820.527178912833;11932.821007684892;12028.45871935765;12041.096917731118;12141.514339426412;10011.449370284705;10015.998400159999;10178.745531361776;10189;10452.059314661718;3301.224212310105;3337.332533493287;3366.091155388056;3416.0947348952545;3416.641252668459;44273.114537709385;44548.55451445509;44907.32639010417;44915.775421122686;44969.77515112436;9463.290253231035;9537.570809313598;9710.028997100233;10032.749181270527;10292.279540432099;17557;17745;17763.11184440773;17788.46634600964;17807.73288400675;6975.686094125776;7000.964995174992;7095.254998225215;7285.4171666266575;7311.451641126937;3424.7773894696766;3448.534447849508;3481.669241422061;3541.8937431877084;3579.302036102935;2880.4671135839935;2984.313607870202;2993.7006299369887;2999.9550006749914;3002.279452931281;461.6283891467334;539.0270561636285;544.6868050870766;547.7726743401444;548.44333002003;576.2393640394639;601.7051644694068;634.8635043465584;640.6508452893185;675.061664286642;7942.166072562413;8018.879716804253;8214.4660597061;8241.917580824234;8421.873671894926;516.4938360406823;575.7466714645543;613.5367797313;639.2361128451456;644.8162273751958;3951.308521008812;3975.662068724133;4092.7953602319767;4113.136241389282;4163.625273725379;41198;45658.31512527315;51648;51773.48226517762;52347;41222.1755564887;41919.161616768106;42451.787741061715;43026.56973430288;43220.78389608032;32272;32774.180645484055;36340.81829590835;37567.81216093957;40607.1878562433;8248.876266855881;8340;8586.925265986623;8601.182887625666;8626.956865215634;28790.280242993256;28881.711182888743;29078.56382154227;29318.7068129316;29710.55434168446;37570.43644345392;38762.22475550417;38779.22441551209;38824.6117538821;39322.41016384814;10173.949130254301;10371;10491.108255798343;10586.947065264625;10706.197035222545;10502;10627.840582391425;11709.648710538697;12485.75028499443;12528.060395470195;10907.836382454429;11346.0355869752;11348.716282093013;11453.312801231952;11464.770704586028;11027;11226.494807733836;11838.112141589587;11859.110566707704;11914.225575337576;11026.44867756625;11234.438278086227;11713.707157321136;11784.4696988634;11791.115666324888;9572.712818615453;9676.27427942893;9971.202303815822;10082.798344033225;10287.22845786554;9780.951095244478;9994.750131246778;9996.350237234556;9997.950010249902;10040.14658754014 21:28:09 INFO - PROCESS | 3377 | __end_tp_report 21:28:09 INFO - PROCESS | 3377 | __start_cc_report 21:28:09 INFO - PROCESS | 3377 | _x_x_mozilla_cycle_collect,810 21:28:09 INFO - PROCESS | 3377 | __end_cc_report 21:28:09 INFO - PROCESS | 3377 | __startTimestamp1461472089773__endTimestamp 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | ------- Summary: start ------- 21:28:09 INFO - PROCESS | 3377 | Number of tests: 6 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | [#0] dojo.html Cycles:165 Average:4650.56 Median:4761.19 stddev:474.46 (10.0%) stddev-sans-first:447.83 21:28:09 INFO - PROCESS | 3377 | Values: 2600.6 2679.1 2681.6 2682.5 2696.2 4557.5 4625.5 4682.6 4684.4 4693.2 4648.4 4682.7 4777.3 4816.5 4820.2 4296.1 4338.6 4361.4 4408.4 4436.4 4321.4 4375.4 4421.6 4454.8 4455.9 4247.4 4325.3 4378.5 4423.3 4425.4 4273.7 4292.7 4310.8 4313.6 4316.9 4204.9 4253.3 4263.0 4268.3 4368.2 4608.5 4608.9 4613.2 4619.8 4644.3 5038.2 5041.4 5051.9 5097.2 5117.0 4925.5 5059.1 5104.6 5173.6 5180.5 4693.4 4723.3 4725.1 4725.8 4727.4 5159.8 5173.6 5174.4 5179.4 5230.5 4799.8 4882.9 4945.8 4977.1 4998.7 5001.1 5016.6 5017.3 5049.3 5073.7 4858.4 5016.8 5017.2 5022.0 5047.6 4906.4 4928.1 5020.3 5031.0 5037.8 4314.8 4339.7 4340.6 4340.8 4384.0 3778.9 3794.8 3797.4 3803.1 3823.5 4195.9 4299.4 4350.1 4391.2 4393.2 4994.2 4995.4 5029.0 5031.5 5074.2 4230.0 4296.3 4303.1 4309.2 4345.0 4524.1 4591.3 4593.0 4631.5 4638.7 4672.9 4684.4 4687.7 4689.2 4710.6 4908.1 4943.0 4972.5 4982.5 5027.5 4720.5 4757.0 4761.2 4768.4 4813.1 4971.8 4975.2 4975.9 4979.2 5027.0 4858.7 4945.5 5052.9 5076.7 5091.7 4880.1 4904.0 4907.5 4935.1 4945.8 4894.9 4912.4 4912.9 4923.6 4923.8 4659.5 4710.5 4757.5 4841.8 4891.1 4780.7 4829.2 4832.0 4847.1 4851.2 4803.9 4861.1 4861.4 4871.4 4908.7 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | [#1] ext.html Cycles:180 Average:43249.31 Median:34657.15 stddev:71503.44 (206.3%) stddev-sans-first:71632.26 21:28:09 INFO - PROCESS | 3377 | Values: 584.2 595.1 600.8 616.7 641.6 27767.4 34724.8 35745.3 35875.6 35934.3 37364.4 38115.2 38125.0 38201.4 38243.6 7272.6 7592.2 7775.0 7776.7 9566.3 9751.0 9899.2 9903.7 9906.8 9909.7 9837.3 9951.0 9953.8 9960.9 9962.1 9822.4 9892.6 9909.4 9915.7 9919.1 9686.2 10073.7 10074.6 10081.7 10089.8 37985.2 38275.4 38415.6 38668.2 38687.8 3239.3 3277.8 3339.9 3403.2 3494.5 29045.0 29365.0 29482.3 29483.6 29680.7 3527.3 3595.4 3605.6 3605.9 3679.6 234774.0 238321.0 238619.8 239486.0 239794.0 53781.5 54460.7 54608.2 54717.5 54725.7 58013.4 58265.7 58549.7 58644.0 58645.4 14184.9 14308.0 14359.9 14393.9 14414.5 9139.8 10294.9 10596.4 10727.4 10754.2 16614.1 16679.0 16801.2 16980.0 17094.9 6024.4 6110.2 6117.8 6337.3 6397.3 953.6 970.6 987.9 992.6 1036.3 28041.6 28165.3 28745.6 28757.3 28814.7 992.9 1033.5 1054.7 1075.0 1098.8 14864.8 15019.6 15215.1 15265.1 15307.8 333818.0 337126.0 340162.0 340225.0 341839.0 49414.3 50003.7 50044.2 50092.0 50107.0 1127.3 1177.4 1197.0 1202.8 1289.5 24391.4 25577.4 26112.9 26117.5 26755.3 33996.0 34376.0 34413.5 34418.5 34473.5 225617.0 230566.0 230890.0 231112.0 231407.0 32027.0 34507.1 38609.0 40070.4 42544.1 40832.0 41063.2 41114.4 41860.8 42091.8 34236.3 34589.5 35111.1 35141.8 35243.6 34793.1 35012.0 35120.0 35432.8 35440.1 31327.0 31463.5 31484.2 33822.0 35092.6 30069.5 31553.4 31719.4 32086.7 32088.0 23910.3 24453.0 24547.5 24874.6 24888.9 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | [#2] jquery.html Cycles:180 Average:23452.95 Median:233714.27 stddev:61089.29 (26.1%) stddev-sans-first:61236.07 21:28:09 INFO - PROCESS | 3377 | Values: 369.2 371.2 374.2 382.6 388.4 16124.2 16434.9 16710.0 16723.5 16746.2 15544.0 15598.8 17435.0 17463.5 17472.7 5092.0 5244.2 5273.3 5276.3 5281.9 3776.2 3973.9 5246.6 5724.0 6063.0 5955.1 6017.8 6029.7 6037.2 6041.1 5895.8 6010.5 6017.0 6020.3 6024.3 3355.7 5000.5 5153.1 5293.3 5300.5 19341.7 19497.7 19627.8 20490.7 21253.3 1886.6 1903.6 1970.4 2067.7 2504.8 13064.4 13075.5 13111.5 13141.3 13593.0 1722.8 1737.7 1775.3 1826.7 1836.9 66919.0 68806.0 69265.7 69590.7 70117.3 9176.3 9202.0 9268.6 9545.8 9666.2 12629.6 12692.4 12733.9 12764.8 12831.6 6869.3 6896.7 6938.8 7047.4 7098.6 6608.4 6626.9 6736.4 6749.9 6760.0 6026.3 6094.4 6096.7 6143.5 6145.9 1559.9 1598.7 1676.9 1800.8 1808.5 882.7 930.2 941.7 983.4 990.4 16417.5 16515.3 16534.0 16691.7 16894.4 885.0 903.8 923.7 937.7 940.1 9988.7 10096.7 10111.8 10119.6 10121.8 138477.0 389897.0 397797.0 410085.0 421293.0 77168.0 81928.6 84054.6 84368.0 84495.6 970.8 973.3 991.7 991.7 1004.0 15225.2 15545.5 15735.5 15935.8 16233.3 31992.2 36326.3 36795.8 37198.3 37593.8 46135.5 51510.0 51514.5 51525.2 51666.5 7525.0 7683.4 7722.0 7781.5 7833.9 10720.2 11764.6 11828.8 11873.5 12353.6 9677.1 9766.8 9986.7 10179.6 10256.1 9760.0 9921.8 10287.5 10319.0 10343.8 10948.6 11067.2 11088.4 11133.0 11167.6 7769.3 7838.8 7858.3 7893.4 7981.3 8142.6 9918.6 10536.8 10561.5 10636.8 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | [#3] mootools.html Cycles:180 Average:5203.78 Median:5164.73 stddev:2885.06 (55.9%) stddev-sans-first:2878.07 21:28:09 INFO - PROCESS | 3377 | Values: 1279.1 1409.3 1460.8 1558.5 1733.4 6829.6 7577.2 7813.2 7824.0 7830.2 7559.7 7716.2 7721.0 7722.7 7731.4 1875.9 1941.7 1944.6 2184.7 2208.7 2136.6 2242.8 2243.8 2244.7 2248.4 2145.5 2146.3 2160.2 2162.5 2218.0 1849.7 2114.9 2207.6 2221.9 2224.5 2211.4 2233.7 2234.1 2236.7 2240.0 7624.5 7658.1 7670.5 7674.7 7684.2 4481.7 4622.5 4629.3 4637.2 4639.2 2975.2 3167.3 3172.9 3177.4 3189.8 972.2 977.9 981.7 992.1 1014.4 10715.4 10742.0 10750.4 10773.5 10793.7 4251.4 4313.5 4473.5 4490.1 4509.4 9080.7 9175.4 9186.3 9197.7 9202.7 4848.6 4855.3 4859.5 4861.9 4863.5 3790.6 3905.7 4325.2 4408.8 4438.6 3705.2 3786.8 3882.9 3884.6 3889.5 1225.5 1259.1 1261.3 1266.2 1266.9 722.7 889.3 902.5 912.0 923.3 5426.4 5450.5 5607.4 5642.1 5644.1 413.4 413.7 418.3 423.9 424.4 3729.4 3804.5 3821.1 3837.9 3990.9 9429.8 9734.3 9740.7 9828.4 9835.6 9524.1 9638.5 9691.9 9700.5 9711.4 7257.8 7395.7 7424.9 7464.6 7507.2 5232.2 5546.0 5626.2 5658.8 5690.3 8553.0 8795.0 8827.0 8877.4 8972.7 8751.6 8929.9 8937.2 9299.5 9359.0 6338.3 6679.7 6898.3 6922.7 6951.5 7452.7 7491.0 7528.8 7565.2 7567.7 6629.7 6863.7 6907.0 6961.7 7012.4 6699.6 6708.7 6750.5 6786.0 6791.0 6305.1 6308.7 6346.9 6364.8 6420.6 4857.9 4893.4 5012.9 5020.7 5097.2 4822.7 4847.1 4891.5 4895.8 4920.4 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | [#4] prototype.html Cycles:180 Average:4453.17 Median:5090.06 stddev:1302.90 (25.6%) stddev-sans-first:1268.78 21:28:09 INFO - PROCESS | 3377 | Values: 303.4 307.7 312.7 318.6 319.5 4913.5 5040.5 5081.2 5145.7 5191.7 4930.3 5081.1 5098.9 5114.1 5119.3 3991.0 4015.8 4018.9 4022.2 4044.9 3809.9 3837.9 4000.2 4040.9 4054.9 3953.1 3956.9 3973.6 3974.5 4005.2 3938.9 3953.8 3955.8 3972.9 3974.1 3412.1 3511.9 3518.7 3528.5 3535.5 4849.2 4857.3 4862.6 4886.1 4902.7 4576.5 4582.4 4584.9 4591.0 4595.2 5255.2 5351.7 5380.7 5381.4 5396.2 3849.9 3860.7 3866.3 3870.5 3874.5 5618.5 5648.1 5648.5 5653.5 5673.7 3962.3 3965.6 3967.8 3970.7 3972.5 3677.2 3888.9 3908.6 3929.0 4029.5 4472.4 4494.0 4496.2 4500.6 4505.3 5354.5 5393.7 5398.5 5411.9 5417.5 1245.2 1279.7 1348.1 1349.9 1351.6 891.8 895.4 918.8 920.9 927.3 4595.3 4631.9 4644.9 4653.3 4653.5 5460.3 5477.8 5479.3 5480.5 5484.8 4511.8 4588.6 4635.6 4638.1 4657.4 2913.0 2925.9 2929.8 2930.2 2933.1 5129.1 5134.4 5142.7 5148.6 5170.6 5471.3 5578.0 5586.9 5614.9 5746.5 5241.8 5250.3 5254.6 5259.0 5263.1 5571.3 5585.5 5593.8 5594.8 5610.2 5293.1 5475.0 5489.9 5524.7 5534.4 5237.4 5239.2 5256.1 5260.6 5271.4 3885.9 3933.7 3938.3 3942.3 3944.2 5190.4 5278.4 5588.1 5592.9 5598.3 5402.6 5408.9 5410.4 5412.4 5420.7 5421.0 5426.5 5430.9 5443.2 5451.5 5043.9 5264.3 5299.0 5359.5 5361.7 5386.0 5421.5 5459.5 5474.8 5476.2 5169.4 5294.1 5299.8 5320.6 5322.8 21:28:09 INFO - PROCESS | 3377 | 21:28:09 INFO - PROCESS | 3377 | [#5] yui.html Cycles:180 Average:12470.64 Median:22291.42 stddev:13446.41 (60.3%) stddev-sans-first:13455.08 21:28:09 INFO - PROCESS | 3377 | Values: 702.7 755.7 774.9 786.2 807.2 12503.7 12969.2 13163.5 13168.8 13169.5 12873.3 13557.5 13695.9 13708.8 13709.7 646.9 793.4 827.5 829.5 834.2 817.0 823.1 824.2 824.5 825.0 851.4 860.1 860.2 860.4 862.4 669.4 837.0 858.0 858.1 869.0 627.1 628.0 628.3 629.9 630.2 12965.8 12973.3 12994.1 12999.3 13011.2 11820.5 11932.8 12028.5 12041.1 12141.5 10011.4 10016.0 10178.7 10189.0 10452.1 3301.2 3337.3 3366.1 3416.1 3416.6 44273.1 44548.6 44907.3 44915.8 44969.8 9463.3 9537.6 9710.0 10032.7 10292.3 17557.0 17745.0 17763.1 17788.5 17807.7 6975.7 7001.0 7095.3 7285.4 7311.5 3424.8 3448.5 3481.7 3541.9 3579.3 2880.5 2984.3 2993.7 3000.0 3002.3 461.6 539.0 544.7 547.8 548.4 576.2 601.7 634.9 640.7 675.1 7942.2 8018.9 8214.5 8241.9 8421.9 516.5 575.7 613.5 639.2 644.8 3951.3 3975.7 4092.8 4113.1 4163.6 41198.0 45658.3 51648.0 51773.5 52347.0 41222.2 41919.2 42451.8 43026.6 43220.8 32272.0 32774.2 36340.8 37567.8 40607.2 8248.9 8340.0 8586.9 8601.2 8627.0 28790.3 28881.7 29078.6 29318.7 29710.6 37570.4 38762.2 38779.2 38824.6 39322.4 10173.9 10371.0 10491.1 10586.9 10706.2 10502.0 10627.8 11709.6 12485.8 12528.1 10907.8 11346.0 11348.7 11453.3 11464.8 11027.0 11226.5 11838.1 11859.1 11914.2 11026.4 11234.4 11713.7 11784.5 11791.1 9572.7 9676.3 9971.2 10082.8 10287.2 9781.0 9994.8 9996.4 9998.0 10040.1 21:28:09 INFO - PROCESS | 3377 | -------- Summary: end -------- 21:28:09 INFO - PROCESS | 3377 | 21:28:10 INFO - TEST-INFO | 3377: exit 0 21:28:10 INFO - TEST-OK | dromaeo_css | took 1118314ms 21:28:10 INFO - TEST-START | kraken 21:28:10 INFO - operating with platform_type : linux_ 21:28:10 INFO - Initialising browser for kraken test... 21:28:10 INFO - TEST-INFO | started process 3558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp60ndH8/profile http://localhost:47682/getInfo.html) 21:28:14 INFO - PROCESS | 3558 | __metrics Screen width/height:1600/1200 21:28:14 INFO - PROCESS | 3558 | colorDepth:24 21:28:14 INFO - PROCESS | 3558 | Browser inner width/height: 1024/697 21:28:14 INFO - PROCESS | 3558 | __metrics 21:28:15 ERROR - PROCESS | 3558 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:28:16 INFO - TEST-INFO | 3558: exit 0 21:28:16 INFO - Browser initialized. 21:28:16 INFO - Running cycle 1/1 for kraken test... 21:28:16 INFO - TEST-INFO | started process 3637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp60ndH8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:28 INFO - PROCESS | 3637 | RSS: Main: 155930624 21:28:28 INFO - PROCESS | 3637 | 21:28:31 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:32 INFO - PROCESS | 3637 | RSS: Main: 210612224 21:28:32 INFO - PROCESS | 3637 | 21:28:34 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-dft) 21:28:35 INFO - PROCESS | 3637 | RSS: Main: 197300224 21:28:35 INFO - PROCESS | 3637 | 21:28:38 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-fft) 21:28:39 INFO - PROCESS | 3637 | RSS: Main: 266264576 21:28:39 INFO - PROCESS | 3637 | 21:28:41 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47682/tests/kraken/driver.html?testName=audio-oscillator) 21:28:41 INFO - PROCESS | 3637 | RSS: Main: 175484928 21:28:41 INFO - PROCESS | 3637 | 21:28:44 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:28:44 INFO - PROCESS | 3637 | RSS: Main: 179912704 21:28:44 INFO - PROCESS | 3637 | 21:28:47 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47682/tests/kraken/driver.html?testName=imaging-darkroom) 21:28:48 INFO - PROCESS | 3637 | RSS: Main: 215199744 21:28:48 INFO - PROCESS | 3637 | 21:28:52 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47682/tests/kraken/driver.html?testName=imaging-desaturate) 21:28:52 INFO - PROCESS | 3637 | RSS: Main: 213172224 21:28:52 INFO - PROCESS | 3637 | 21:28:55 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47682/tests/kraken/driver.html?testName=json-parse-financial) 21:28:56 INFO - PROCESS | 3637 | RSS: Main: 214671360 21:28:56 INFO - PROCESS | 3637 | 21:28:57 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:28:58 INFO - PROCESS | 3637 | RSS: Main: 202190848 21:28:58 INFO - PROCESS | 3637 | 21:29:00 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:00 INFO - PROCESS | 3637 | RSS: Main: 204111872 21:29:00 INFO - PROCESS | 3637 | 21:29:03 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:03 INFO - PROCESS | 3637 | RSS: Main: 216866816 21:29:03 INFO - PROCESS | 3637 | 21:29:06 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:07 INFO - PROCESS | 3637 | RSS: Main: 225157120 21:29:07 INFO - PROCESS | 3637 | 21:29:10 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:10 INFO - PROCESS | 3637 | RSS: Main: 219734016 21:29:10 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:47682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47682/tests/kraken/driver.html?testName=ai-astar) 21:29:12 INFO - PROCESS | 3637 | RSS: Main: 283639808 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | __start_tp_report 21:29:12 INFO - PROCESS | 3637 | _x_x_mozilla_page_load 21:29:12 INFO - PROCESS | 3637 | _x_x_mozilla_page_load_details 21:29:12 INFO - PROCESS | 3637 | |i|pagename|runs| 21:29:12 INFO - PROCESS | 3637 | |0;ai-astar;113;114;108;112;114;113;104;113;113;113 21:29:12 INFO - PROCESS | 3637 | |1;audio-beat-detection;166;130;156;188;132;157;161;135;193;132 21:29:12 INFO - PROCESS | 3637 | |2;audio-dft;161;161;160;160;162;163;161;161;160;161 21:29:12 INFO - PROCESS | 3637 | |3;audio-fft;74;74;117;109;74;74;73;113;102;73 21:29:12 INFO - PROCESS | 3637 | |4;audio-oscillator;95;95;157;94;95;94;148;94;95;149 21:29:12 INFO - PROCESS | 3637 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;117;117 21:29:12 INFO - PROCESS | 3637 | |6;imaging-darkroom;145;146;145;146;145;146;145;146;147;145 21:29:12 INFO - PROCESS | 3637 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;94;94 21:29:12 INFO - PROCESS | 3637 | |8;json-parse-financial;66;66;72;67;66;66;65;82;64;65 21:29:12 INFO - PROCESS | 3637 | |9;json-stringify-tinderbox;65;65;65;64;64;65;64;64;64;64 21:29:12 INFO - PROCESS | 3637 | |10;stanford-crypto-aes;78;79;78;78;79;80;79;79;79;79 21:29:12 INFO - PROCESS | 3637 | |11;stanford-crypto-ccm;136;132;132;131;134;130;134;142;171;142 21:29:12 INFO - PROCESS | 3637 | |12;stanford-crypto-pbkdf2;175;173;172;171;169;170;173;172;172;174 21:29:12 INFO - PROCESS | 3637 | |13;stanford-crypto-sha256-iterative;72;73;72;72;74;71;76;70;70;70 21:29:12 INFO - PROCESS | 3637 | __end_tp_report 21:29:12 INFO - PROCESS | 3637 | __start_cc_report 21:29:12 INFO - PROCESS | 3637 | _x_x_mozilla_cycle_collect,1894 21:29:12 INFO - PROCESS | 3637 | __end_cc_report 21:29:12 INFO - PROCESS | 3637 | __startTimestamp1461472152700__endTimestamp 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | ------- Summary: start ------- 21:29:12 INFO - PROCESS | 3637 | Number of tests: 14 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:3.36 21:29:12 INFO - PROCESS | 3637 | Values: 113.0 114.0 108.0 112.0 114.0 113.0 104.0 113.0 113.0 113.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:159.00 stddev:23.04 (14.5%) stddev-sans-first:24.09 21:29:12 INFO - PROCESS | 3637 | Values: 166.0 130.0 156.0 188.0 132.0 157.0 161.0 135.0 193.0 132.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 21:29:12 INFO - PROCESS | 3637 | Values: 161.0 161.0 160.0 160.0 162.0 163.0 161.0 161.0 160.0 161.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.50 stddev:19.25 (26.2%) stddev-sans-first:19.71 21:29:12 INFO - PROCESS | 3637 | Values: 74.0 74.0 117.0 109.0 74.0 74.0 73.0 113.0 102.0 73.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:94.50 stddev:27.52 (29.1%) stddev-sans-first:28.53 21:29:12 INFO - PROCESS | 3637 | Values: 95.0 95.0 157.0 94.0 95.0 94.0 148.0 94.0 95.0 149.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:29:12 INFO - PROCESS | 3637 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 21:29:12 INFO - PROCESS | 3637 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 147.0 145.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:29:12 INFO - PROCESS | 3637 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:66.00 stddev:5.40 (8.2%) stddev-sans-first:5.69 21:29:12 INFO - PROCESS | 3637 | Values: 66.0 66.0 72.0 67.0 66.0 66.0 65.0 82.0 64.0 65.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 21:29:12 INFO - PROCESS | 3637 | Values: 65.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 21:29:12 INFO - PROCESS | 3637 | Values: 78.0 79.0 78.0 78.0 79.0 80.0 79.0 79.0 79.0 79.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:135.00 stddev:12.20 (9.0%) stddev-sans-first:12.91 21:29:12 INFO - PROCESS | 3637 | Values: 136.0 132.0 132.0 131.0 134.0 130.0 134.0 142.0 171.0 142.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:1.79 (1.0%) stddev-sans-first:1.56 21:29:12 INFO - PROCESS | 3637 | Values: 175.0 173.0 172.0 171.0 169.0 170.0 173.0 172.0 172.0 174.0 21:29:12 INFO - PROCESS | 3637 | 21:29:12 INFO - PROCESS | 3637 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.94 (2.7%) stddev-sans-first:2.06 21:29:12 INFO - PROCESS | 3637 | Values: 72.0 73.0 72.0 72.0 74.0 71.0 76.0 70.0 70.0 70.0 21:29:12 INFO - PROCESS | 3637 | -------- Summary: end -------- 21:29:12 INFO - PROCESS | 3637 | 21:29:13 INFO - TEST-INFO | 3637: exit 0 21:29:13 INFO - TEST-OK | kraken | took 63127ms 21:29:13 INFO - SUITE-END | took 1181s 21:29:13 INFO - Completed test suite (00:19:41) 21:29:13 INFO - javascript benchmark 21:29:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.59690747934, 2679.0623281851367, 2681.5709486482165, 2682.517146913555, 2696.1641891013787, 4557.544245575441, 4625.537446255373, 4682.601978831799, 4684.391029166208, 4693.249080147173, 4648.442186937572, 4682.742449165295, 4777.259524773657, 4816.470188279286, 4820.180569303218, 4296.140771845636, 4338.566143385668, 4361.3676016977515, 4408.42690450241, 4436.423264975549, 4321.373400856874, 4375.4311939447825, 4421.624161946238, 4454.777261136946, 4455.866324010269, 4247.447831781879, 4325.286327755916, 4378.474583050022, 4423.336499525097, 4425.380446737459, 4273.722208056497, 4292.678049146295, 4310.762908040057, 4313.568643135693, 4316.892077698051, 4204.8528301509605, 4253.319468884994, 4262.957370426287, 4268.317069268902, 4368.213721530124, 4608.493065762764, 4608.861734147948, 4613.192691279013, 4619.838305659319, 4644.349791029259, 5038.193888977783, 5041.395032596112, 5051.898962020739, 5097.23541468779, 5117.002184574009, 4925.458199598042, 5059.139946209153, 5104.64267501275, 5173.58611311098, 5180.533751962342, 4693.389859318267, 4723.315119307681, 4725.149473094807, 4725.834595789131, 4727.432708075053, 5159.819406320761, 5173.560247379015, 5174.43081261061, 5179.352580927384, 5230.476952304739, 4799.760011999386, 4882.926756098661, 4945.752712364368, 4977.0792403405485, 4998.650094493423, 5001.124803159505, 5016.598672106223, 5017.347744793154, 5049.293098966147, 5073.670211436245, 4858.416989961227, 5016.799328026911, 5017.197248440232, 5021.974890125526, 5047.621428392885, 4906.411230652345, 4928.112939670894, 5020.347354843847, 5030.974845125751, 5037.798488060436, 4314.80583373749, 4339.674524410619, 4340.587644173798, 4340.76125813077, 4384.0355121873135, 3778.8677396290996, 3794.8102594870147, 3797.4493698413576, 3803.125281185343, 3823.4647149399107, 4195.916081678411, 4299.441072660597, 4350.129974005212, 4391.165678521071, 4393.165298593257, 4994.175960966472, 4995.425526064477, 5029.0, 5031.52200540948, 5074.162763144113, 4229.97885010573, 4296.2696341621995, 4303.117860838521, 4309.245881970705, 4345.022369966732, 4524.09518096382, 4591.311303304531, 4592.977035114803, 4631.467381251199, 4638.698484598491, 4672.906541869143, 4684.437867455791, 4687.718736875799, 4689.202835518038, 4710.552497512731, 4908.092002979461, 4943.0, 4972.477889821516, 4982.4768399317545, 5027.497250274943, 4720.504347043511, 4757.0, 4761.190597598347, 4768.427788665383, 4813.061453016629, 4971.825986090469, 4975.154223782039, 4975.925361119514, 4979.228219625964, 5026.974865125651, 4858.684185527929, 4945.530174633404, 5052.898942021213, 5076.7207803571155, 5091.66904151229, 4880.072786170616, 4903.95096049035, 4907.460179380194, 4935.062338155739, 4945.826896058621, 4894.92657610129, 4912.38595175603, 4912.852614421573, 4923.556879880828, 4923.848522994716, 4659.534046595313, 4710.528947105262, 4757.476677565396, 4841.806327746851, 4891.144049791344, 4780.665353425227, 4829.227323628203, 4831.96112835742, 4847.079054979543, 4851.223804191312, 4803.903921921472, 4861.149298872754, 4861.368022157097, 4871.391076115486, 4908.7300198488], "value": 4621.26292729282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1704779213517, 595.1370512756503, 600.78371786157, 616.7224748863013, 641.5605310362399, 27767.444651106965, 34724.82637586811, 35745.285094298095, 35875.64124358755, 35934.2813143737, 37364.43953340702, 38115.237695246076, 38125.0, 38201.42697859527, 38243.61756382435, 7272.63636818157, 7592.20281870404, 7774.961125194366, 7776.65005074773, 9566.330356875022, 9750.951245243763, 9899.15857152143, 9903.653372131941, 9906.801863962717, 9909.653162139326, 9837.311388202828, 9951.004899510064, 9953.800923981516, 9960.900390996107, 9962.053604907558, 9822.410655360665, 9892.55483503237, 9909.355891867006, 9915.652952146713, 9919.057689519484, 9686.15962967034, 10073.748156296078, 10074.597016119347, 10081.747956301078, 10089.848652270222, 37985.24029519422, 38275.425868611994, 38415.61584384176, 38668.226635467414, 38687.806560967016, 3239.2549713566013, 3277.7705560610766, 3339.9499007514905, 3403.23427228874, 3494.5457090578316, 29045.0, 29364.972225972204, 29482.262943426373, 29483.557746633818, 29680.70319296801, 3527.2592755521373, 3595.352836489431, 3605.6214097519905, 3605.855765769366, 3679.558452985632, 234774.0, 238321.0, 238619.80690096613, 239486.0, 239794.0, 53781.50420222673, 54460.72769636206, 54608.180877286875, 54717.452825472035, 54725.72637136789, 58013.41986580165, 58265.70867145637, 58549.70725146347, 58644.0, 58645.413545863994, 14184.929075354763, 14308.0, 14359.85640143606, 14393.92803035978, 14414.495492657916, 9139.77150571241, 10294.897051029544, 10596.417197054081, 10727.409992450333, 10754.247202695893, 16614.086225257484, 16679.0, 16801.24394402255, 16980.0, 17094.91452542729, 6024.367441418588, 6110.175126357974, 6117.816465505953, 6337.271213810379, 6397.264314603787, 953.5899563187896, 970.6311601591491, 987.8814542254831, 992.5682328187262, 1036.2953191829477, 28041.57937630937, 28165.295867603472, 28745.56881646777, 28757.28106797347, 28814.71185288162, 992.925530585209, 1033.4987531047436, 1054.699410667956, 1074.957001719938, 1098.7912296663608, 14864.777028344584, 15019.624509387135, 15215.109129265404, 15265.06355032832, 15307.846921530641, 333818.0, 337126.0, 340162.0, 340225.0, 341839.0, 49414.25878611824, 50003.749981249865, 50044.249336259985, 50092.0, 50107.0, 1127.3236058364917, 1177.4112943528237, 1196.976060478803, 1202.8255902893857, 1289.4777615065914, 24391.390215244763, 25577.360565986, 26112.8694356527, 26117.477650447265, 26755.33111672224, 33996.0, 34376.0, 34413.483797742556, 34418.48372274368, 34473.482897756054, 225617.0, 230566.0, 230890.0, 231112.0, 231407.0, 32027.0, 34507.13732156716, 38609.0, 40070.398944016444, 42544.1491170181, 40832.0, 41063.1787364257, 41114.38328425136, 41860.79069604632, 42091.7895410521, 34236.31527369389, 34589.48115778215, 35111.12222194466, 35141.82429087838, 35243.647563524035, 34793.130171744895, 35012.0, 35120.0, 35432.82283588566, 35440.11399715028, 31327.0, 31463.52804707977, 31484.2128946769, 33822.0, 35092.64907350894, 30069.54895676523, 31553.368932621677, 31719.365612688078, 32086.67913320837, 32088.0, 23910.28269151928, 24453.0, 24547.509049819262, 24874.626880596443, 24888.875555622108], "value": 17712.053892630098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.21910160011566, 371.17413754396455, 374.16187739463595, 382.59444988312407, 388.37471670610313, 16124.19379031048, 16434.93172943758, 16710.0, 16723.49829505115, 16746.16269186542, 15544.0, 15598.84401155988, 17435.041072740994, 17463.476095717117, 17472.737908931344, 5091.974540127294, 5244.160934250521, 5273.314469119009, 5276.34045744282, 5281.947180528184, 3776.169242766587, 3973.9006524836964, 5246.632735708502, 5723.971380143114, 6062.999605065181, 5955.076963070731, 6017.789377371793, 6029.728662210189, 6037.184980027684, 6041.063635136539, 5895.823125306248, 6010.549208809357, 6017.007193813038, 6020.2775666919815, 6024.2770867495965, 3355.697987181141, 5000.524950129732, 5153.072446959546, 5293.258943747878, 5300.549453296474, 19341.709874351895, 19497.707534386995, 19627.803721962882, 20490.692639610417, 21253.256136035165, 1886.6038131992298, 1903.6097599992106, 1970.3990282963691, 2067.7105205271273, 2504.8246622736415, 13064.412101455457, 13075.476980920752, 13111.541096061592, 13141.27722975236, 13593.0, 1722.8277172282797, 1737.6959032169445, 1775.2632657447143, 1826.6620675175136, 1836.898970556619, 66919.0, 68806.0, 69265.65367173131, 69590.65204673995, 70117.29882701159, 9176.265898728087, 9201.95399023014, 9268.629254829866, 9545.761355966157, 9666.178374838217, 12629.557965471164, 12692.42884070219, 12733.872661273454, 12764.80852787209, 12831.550895718792, 6869.347411995853, 6896.655137253358, 6938.791836244921, 7047.43620510358, 7098.574085554883, 6608.43828274602, 6626.867462650816, 6736.393724564813, 6749.898751518731, 6759.966200168968, 6026.337102918676, 6094.360092190256, 6096.695165241809, 6143.477804386677, 6145.877082458326, 1559.8518140776607, 1598.696247712931, 1676.8910020848605, 1800.8109148539215, 1808.52074200337, 882.6557642519423, 930.2232635749225, 941.7080704981478, 983.3706427886159, 990.4305024610877, 16417.507474775775, 16515.256813443422, 16534.0, 16691.666166676598, 16894.40869569559, 884.951327676984, 903.8056817784208, 923.7182659288982, 937.7280588629221, 940.0634990037889, 9988.652666623339, 10096.747581310527, 10111.848322275171, 10119.59521619127, 10121.848172277421, 138477.0, 389897.0, 397797.0, 410085.0, 421293.0, 77168.0, 81928.59035704784, 84054.5797271022, 84368.0, 84495.57752211322, 970.815545046439, 973.3089506450499, 991.6578780320777, 991.667791289926, 1003.9799204015878, 15225.238738062832, 15545.455909043128, 15735.527934161993, 15935.840641593899, 16233.269502872163, 31992.200194995312, 36326.27347452983, 36795.81602092079, 37198.29200689125, 37593.81203093967, 46135.53864461447, 51510.0, 51514.48485515097, 51525.227121593955, 51666.483335166165, 7524.962375188089, 7683.423743219393, 7721.961390193013, 7781.494202876795, 7833.921660783547, 10720.19598530129, 11764.647060588197, 11828.76342473163, 11873.470587942184, 12353.629391117922, 9677.129058384779, 9766.804663906823, 9986.650467233612, 10179.592816287266, 10256.12822910061, 9759.951200243953, 9921.751956201153, 10287.53706083243, 10319.0, 10343.844842327522, 10948.56205751793, 11067.169962253025, 11088.390138542458, 11132.998030177323, 11167.553297867995, 7769.339606133542, 7838.764837054898, 7858.292753652198, 7893.447458677838, 7981.321587665114, 8142.633581488729, 9918.603255869684, 10536.78926421452, 10561.471926403496, 10636.84044739314], "value": 8378.054517215414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.079063074586, 1409.3235247081398, 1460.8247010358757, 1558.5402306319634, 1733.4106403822698, 6829.6243706596115, 7577.242275772427, 7813.218678132198, 7824.021997250344, 7830.216978302174, 7559.69761209551, 7716.151223365426, 7721.0, 7722.65248063837, 7731.420143489247, 1875.9155837987255, 1941.708743688444, 1944.6499630066583, 2184.737831460227, 2208.6686996950425, 2136.6260904341757, 2242.831787615927, 2243.798058174764, 2244.652078927769, 2248.392933907844, 2145.4529095080734, 2146.291723731165, 2160.2331172433796, 2162.4810045589024, 2217.979729324513, 1849.657813304543, 2114.8625339352893, 2207.569523942832, 2221.9223676516876, 2224.4661281292533, 2211.4139752965475, 2233.6649502574583, 2234.0505285253703, 2236.731592208945, 2240.047979608676, 7624.504407213513, 7658.119316278644, 7670.5397676139055, 7674.654640541189, 7684.154742978268, 4481.6638752093395, 4622.537746225385, 4629.305604159369, 4637.234856248715, 4639.164950308943, 2975.1669532530927, 3167.303193297471, 3172.888948886801, 3177.4280629486684, 3189.8086114832954, 972.1736523954653, 977.8826540815077, 981.7103954333418, 992.0872797026752, 1014.4319181258519, 10715.357078575233, 10742.0, 10750.354978701303, 10773.4613269337, 10793.730156746065, 4251.44731184944, 4313.547077556874, 4473.46318441789, 4490.057088011489, 4509.436320459942, 9080.727578172666, 9175.403598766059, 9186.26509879208, 9197.678081267124, 9202.677906273382, 4848.612111031109, 4855.344528488608, 4859.489753575824, 4861.9027619447415, 4863.489333619989, 3790.6019867914024, 3905.668018218483, 4325.2214601371425, 4408.845690400821, 4438.60052595268, 3705.203381273039, 3786.7917264550165, 3882.941755873664, 3884.5532763731967, 3889.4943657324366, 1225.5036710132233, 1259.1060347153623, 1261.2999785119164, 1266.1896386312767, 1266.892314153289, 722.6747963416484, 889.3107841422819, 902.4720538484928, 911.981760364789, 923.2706162131841, 5426.430224826416, 5450.5367043800925, 5607.355154157242, 5642.069058605366, 5644.125160600113, 413.3737387857398, 413.6876658123098, 418.2972606021912, 423.8558889977422, 424.448217317486, 3729.3846515324667, 3804.505414296124, 3821.082940094413, 3837.9040523986564, 3990.900227494336, 9429.76425589352, 9734.318597698093, 9740.707778766648, 9828.361156524803, 9835.557399917021, 9524.095210954949, 9638.518074096268, 9691.854622180674, 9700.514974251259, 9711.417314960983, 7257.818554536178, 7395.7041718330665, 7424.925750742424, 7464.552126872297, 7507.249275072449, 5232.241325007929, 5545.972270138624, 5626.24045753818, 5658.830235092953, 5690.2887139107615, 8553.0, 8795.0, 8827.0, 8877.378583499092, 8972.685955991508, 8751.562421879007, 8929.883764529433, 8937.195652391316, 9299.535023248945, 9358.953205234202, 6338.334474880071, 6679.6994135265, 6898.275681053417, 6922.723091076301, 6951.513394062367, 7452.739154129579, 7491.0, 7528.8494230116185, 7565.167831538416, 7567.735129270449, 6629.668516574248, 6863.725450982104, 6906.965465172642, 6961.651917404009, 7012.368886800213, 6699.631520266432, 6708.664566771739, 6750.459963202834, 6786.0, 6791.0, 6305.148804911279, 6308.747650093945, 6346.873062538631, 6364.840878978062, 6420.6468644225015, 4857.854264372075, 4893.388326459192, 5012.899742005066, 5020.723860187724, 5097.209932460474, 4822.71063736177, 4847.079054979543, 4891.5353041461, 4895.804167833389, 4920.40955085392], "value": 4139.310881295692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.4098678071151, 307.6830864209864, 312.7482376686768, 318.56356791196066, 319.4696803306509, 4913.459519452857, 5040.495950404967, 5081.187010078388, 5145.691258524491, 5191.688498690081, 4930.285108659242, 5081.1108056090125, 5098.923516147252, 5114.079465696173, 5119.336215729893, 3991.0, 4015.799210039501, 4018.859339923103, 4022.235775202702, 4044.9191016179657, 3809.9238015239816, 3837.884863454101, 4000.159966407058, 4040.919181616366, 4054.939175912349, 3953.0907891185043, 3956.861509847156, 3973.562908080109, 3974.5230572331216, 4005.218982298453, 3938.8818335449982, 3953.8220780064967, 3955.8219880105466, 3972.920541589181, 3974.125692347679, 3412.146963259185, 3511.9297614047578, 3518.665726755954, 3528.4883691864534, 3535.5403797506415, 4849.248366503198, 4857.34425852509, 4862.586680132193, 4886.120498310338, 4902.7058376497525, 4576.54234576543, 4582.358469814229, 4584.931226031612, 4591.0, 4595.2188128018315, 5255.211718242256, 5351.7324133793545, 5380.677159370412, 5381.381141168777, 5396.163594642798, 3849.903752406184, 3860.7297489175767, 3866.3040652682507, 3870.4774855394444, 3874.4575759393706, 5618.4662457066515, 5648.096304591246, 5648.491635752802, 5653.519450846683, 5673.687947162863, 3962.346212874901, 3965.643092121723, 3967.821448034845, 3970.722049456568, 3972.503437070366, 3677.1542545214215, 3888.922221555553, 3908.5700572936953, 3928.958825911136, 4029.516458024997, 4472.44094488189, 4493.977710030499, 4496.235639941217, 4500.617447516932, 4505.324201369821, 5354.464553544614, 5393.7033463159905, 5398.460153984649, 5411.918821217685, 5417.4808713948205, 1245.2341809786915, 1279.705667696435, 1348.1169833758904, 1349.878510934001, 1351.6215459671307, 891.790429249126, 895.4492986813063, 918.7749001494676, 920.8526635738384, 927.3091546797679, 4595.264757638762, 4631.884202894955, 4644.930326045112, 4653.325267836145, 4653.488116307203, 5460.290162278879, 5477.75350109246, 5479.2602998594675, 5480.479354461319, 5484.780608775684, 4511.751853648016, 4588.609968152745, 4635.605973492224, 4638.1187574360765, 4657.441107067174, 2912.956305655417, 2925.8683359248885, 2929.7949143559745, 2930.17954972608, 2933.12006398084, 5129.127868328033, 5134.358205224347, 5142.665726727751, 5148.639595228298, 5170.560502357342, 5471.316085489314, 5578.0, 5586.888262234733, 5614.9438505615235, 5746.454086861741, 5241.790328386822, 5250.343707036621, 5254.605904557174, 5258.97370513145, 5263.131583288791, 5571.331440227036, 5585.525230355465, 5593.8321850344555, 5594.832155035356, 5610.158476228598, 5293.100172970681, 5475.001624406983, 5489.890202196014, 5524.696141712245, 5534.418886016911, 5237.4238833727495, 5239.240310155083, 5256.132738098324, 5260.631755777059, 5271.367435907716, 3885.8834234972996, 3933.7443066200603, 3938.2714197873483, 3942.3298039333954, 3944.2308749793515, 5190.429052804264, 5278.366596008504, 5588.105903055492, 5592.86017849557, 5598.3282006159525, 5402.568844020285, 5408.917566736756, 5410.350757908918, 5412.350517937873, 5420.674759514442, 5420.972895135499, 5426.484483974016, 5430.9185362218805, 5443.237946687546, 5451.454854514517, 5043.873903152304, 5264.341957255343, 5299.0, 5359.544438722753, 5361.705106219196, 5385.976664433745, 5421.457854214547, 5459.535939445032, 5474.7810087597645, 5476.151196564539, 5169.431362550041, 5294.126469132704, 5299.7615107321035, 5320.600954928318, 5322.840314790563], "value": 4036.057690629538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.6627218934914, 755.7203834581204, 774.856651519469, 786.2255678157014, 807.192807192807, 12503.687407814798, 12969.221846689194, 13163.47346106157, 13168.802467962989, 13169.473221071146, 12873.291968941705, 13557.457701691945, 13695.863041369583, 13708.794368084462, 13709.725805483884, 646.8609249011462, 793.4168386236112, 827.4704189318826, 829.4857188543111, 834.1950018232404, 816.9714060007901, 823.1398188892591, 824.1675907333577, 824.4640983360804, 825.0182283083142, 851.4082712514804, 860.0797147052656, 860.2300940658107, 860.42781550269, 862.3747782857441, 669.4142625202948, 836.9788857593726, 858.0175698824842, 858.0861382627481, 868.9913100868973, 627.1251604012423, 627.9686015699197, 628.346519619595, 629.9401556852092, 630.1713247080121, 12965.805512917314, 12973.286469244187, 12994.090413671047, 12999.285039322833, 13011.21932684042, 11820.527178912833, 11932.821007684892, 12028.45871935765, 12041.096917731118, 12141.514339426412, 10011.449370284705, 10015.998400159999, 10178.745531361776, 10189.0, 10452.059314661718, 3301.224212310105, 3337.332533493287, 3366.091155388056, 3416.0947348952545, 3416.641252668459, 44273.114537709385, 44548.55451445509, 44907.32639010417, 44915.775421122686, 44969.77515112436, 9463.290253231035, 9537.570809313598, 9710.028997100233, 10032.749181270527, 10292.279540432099, 17557.0, 17745.0, 17763.11184440773, 17788.46634600964, 17807.73288400675, 6975.686094125776, 7000.964995174992, 7095.254998225215, 7285.4171666266575, 7311.451641126937, 3424.7773894696766, 3448.534447849508, 3481.669241422061, 3541.8937431877084, 3579.302036102935, 2880.4671135839935, 2984.313607870202, 2993.7006299369887, 2999.9550006749914, 3002.279452931281, 461.6283891467334, 539.0270561636285, 544.6868050870766, 547.7726743401444, 548.44333002003, 576.2393640394639, 601.7051644694068, 634.8635043465584, 640.6508452893185, 675.061664286642, 7942.166072562413, 8018.879716804253, 8214.4660597061, 8241.917580824234, 8421.873671894926, 516.4938360406823, 575.7466714645543, 613.5367797313, 639.2361128451456, 644.8162273751958, 3951.308521008812, 3975.662068724133, 4092.7953602319767, 4113.136241389282, 4163.625273725379, 41198.0, 45658.31512527315, 51648.0, 51773.48226517762, 52347.0, 41222.1755564887, 41919.161616768106, 42451.787741061715, 43026.56973430288, 43220.78389608032, 32272.0, 32774.180645484055, 36340.81829590835, 37567.81216093957, 40607.1878562433, 8248.876266855881, 8340.0, 8586.925265986623, 8601.182887625666, 8626.956865215634, 28790.280242993256, 28881.711182888743, 29078.56382154227, 29318.7068129316, 29710.55434168446, 37570.43644345392, 38762.22475550417, 38779.22441551209, 38824.6117538821, 39322.41016384814, 10173.949130254301, 10371.0, 10491.108255798343, 10586.947065264625, 10706.197035222545, 10502.0, 10627.840582391425, 11709.648710538697, 12485.75028499443, 12528.060395470195, 10907.836382454429, 11346.0355869752, 11348.716282093013, 11453.312801231952, 11464.770704586028, 11027.0, 11226.494807733836, 11838.112141589587, 11859.110566707704, 11914.225575337576, 11026.44867756625, 11234.438278086227, 11713.707157321136, 11784.4696988634, 11791.115666324888, 9572.712818615453, 9676.27427942893, 9971.202303815822, 10082.798344033225, 10287.22845786554, 9780.951095244478, 9994.750131246778, 9996.350237234556, 9997.950010249902, 10040.14658754014], "value": 5993.773759008505, "unit": "score"}], "name": "dromaeo_css", "value": 6399.329043937407, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 108.0, 112.0, 114.0, 113.0, 104.0, 113.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 130.0, 156.0, 188.0, 132.0, 157.0, 161.0, 135.0, 193.0, 132.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 163.0, 161.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 117.0, 109.0, 74.0, 74.0, 73.0, 113.0, 102.0, 73.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 157.0, 94.0, 95.0, 94.0, 148.0, 94.0, 95.0, 149.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 67.0, 66.0, 66.0, 65.0, 82.0, 64.0, 65.0], "value": 67.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 132.0, 131.0, 134.0, 130.0, 134.0, 142.0, 171.0, 142.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 172.0, 171.0, 169.0, 170.0, 173.0, 172.0, 172.0, 174.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 71.0, 76.0, 70.0, 70.0, 70.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1578.1000000000001, "alertThreshold": 2.0}]} 21:29:13 INFO - Return code: 0 21:29:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:29:13 ERROR - # TBPL SUCCESS # 21:29:13 INFO - Running post-action listener: _resource_record_post_action 21:29:13 INFO - Running post-run listener: _resource_record_post_run 21:29:15 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 16384; Write bytes: 519196672; Read time: 312; Write time: 622236 21:29:15 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240656384; Read time: 0; Write time: 327916 21:29:15 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 16384; Write bytes: 278163456; Read time: 312; Write time: 294320 21:29:15 INFO - Running post-run listener: _upload_blobber_files 21:29:15 INFO - Blob upload gear active. 21:29:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29:15 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:15 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:15 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:15 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:29:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:29:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:16 INFO - (blobuploader) - INFO - Done attempting. 21:29:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:29:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:29:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:17 INFO - (blobuploader) - INFO - Done attempting. 21:29:17 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:17 INFO - Return code: 0 21:29:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f19b6e18691c43042e8a226ddad56b1bb01258222eef09b0458a4a44f529d518b42f9cc00e2233dd6e0ae5d778e3f8cf9e6c3363385294dabdda284f853420c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11250000f71604cafdc7f9e3d9f62c8baac6b3dfe25296e47cb3344fa1f3fdb85f4c54e47f5a9ed5b9576e747dd704c8d3b6c59a5423824ab9f367b3a5add630"} 21:29:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:17 INFO - Contents: 21:29:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f19b6e18691c43042e8a226ddad56b1bb01258222eef09b0458a4a44f529d518b42f9cc00e2233dd6e0ae5d778e3f8cf9e6c3363385294dabdda284f853420c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11250000f71604cafdc7f9e3d9f62c8baac6b3dfe25296e47cb3344fa1f3fdb85f4c54e47f5a9ed5b9576e747dd704c8d3b6c59a5423824ab9f367b3a5add630"} 21:29:17 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:17 INFO - Copying logs to upload dir... 21:29:17 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.807492 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-23 21:29:16.754470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:16.760355) ========= 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=62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f19b6e18691c43042e8a226ddad56b1bb01258222eef09b0458a4a44f529d518b42f9cc00e2233dd6e0ae5d778e3f8cf9e6c3363385294dabdda284f853420c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11250000f71604cafdc7f9e3d9f62c8baac6b3dfe25296e47cb3344fa1f3fdb85f4c54e47f5a9ed5b9576e747dd704c8d3b6c59a5423824ab9f367b3a5add630"} 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.011106 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f19b6e18691c43042e8a226ddad56b1bb01258222eef09b0458a4a44f529d518b42f9cc00e2233dd6e0ae5d778e3f8cf9e6c3363385294dabdda284f853420c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11250000f71604cafdc7f9e3d9f62c8baac6b3dfe25296e47cb3344fa1f3fdb85f4c54e47f5a9ed5b9576e747dd704c8d3b6c59a5423824ab9f367b3a5add630"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:16.784407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:16.784681) ========= 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=62c568580acbfdaac3eec7be000001dc-1461470856.676488-1508329457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004337 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 21:29:16.867403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 21:29:16.867686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 21:29:16.867937) ========= ========= Total master_lag: 0.17 =========