builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1461065833.59 results: success (0) buildid: 20160419032946 builduid: 888dd407cf58424d8f5448d914a222f8 revision: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.589784) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.590368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.590653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.608486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.608801) ========= 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-1461065319.464287-514348873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 04:37:13-- 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% 223M=0s 2016-04-19 04:37:13 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.748503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.748833) ========= 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-1461065319.464287-514348873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017741 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.799000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.799384) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 --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 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 --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-1461065319.464287-514348873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 04:37:13,822 truncating revision to first 12 chars 2016-04-19 04:37:13,822 Setting DEBUG logging. 2016-04-19 04:37:13,822 attempt 1/10 2016-04-19 04:37:13,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29d7a174bdb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 04:37:14,115 unpacking tar archive at: fx-team-29d7a174bdb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.405326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.405901) ========= script_repo_revision: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.406453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.406885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.416789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-19 04:37:14.417093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:37:14 INFO - MultiFileLogger online at 20160419 04:37:14 in /builds/slave/test 04:37:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:37:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:14 INFO - {'append_to_log': False, 04:37:14 INFO - 'base_work_dir': '/builds/slave/test', 04:37:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:37:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:14 INFO - 'branch': 'Fx-Team-Non-PGO', 04:37:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:14 INFO - 'config_files': ('talos/linux_config.py',), 04:37:14 INFO - 'default_actions': ('clobber', 04:37:14 INFO - 'read-buildbot-config', 04:37:14 INFO - 'download-and-extract', 04:37:14 INFO - 'populate-webroot', 04:37:14 INFO - 'create-virtualenv', 04:37:14 INFO - 'install', 04:37:14 INFO - 'run-tests'), 04:37:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:14 INFO - 'download_minidump_stackwalk': True, 04:37:14 INFO - 'download_symbols': 'ondemand', 04:37:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:14 INFO - 'installer_path': 'installer.exe', 04:37:14 INFO - 'log_level': 'info', 04:37:14 INFO - 'log_name': 'talos', 04:37:14 INFO - 'log_to_console': True, 04:37:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:37:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:37:14 INFO - 'opt_config_files': (), 04:37:14 INFO - 'pip_index': False, 04:37:14 INFO - 'sps_profile': False, 04:37:14 INFO - 'sps_profile_interval': 0, 04:37:14 INFO - 'suite': 'dromaeojs-e10s', 04:37:14 INFO - 'system_bits': '32', 04:37:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:14 INFO - 'title': 'talos-linux64-ix-018', 04:37:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:14 INFO - 'use_talos_json': True, 04:37:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:14 INFO - 'work_dir': 'build'} 04:37:14 INFO - ##### 04:37:14 INFO - ##### Running clobber step. 04:37:14 INFO - ##### 04:37:14 INFO - Running pre-action listener: _resource_record_pre_action 04:37:14 INFO - Running main action method: clobber 04:37:14 INFO - rmtree: /builds/slave/test/build 04:37:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:14 INFO - Running post-action listener: _resource_record_post_action 04:37:14 INFO - ##### 04:37:14 INFO - ##### Running read-buildbot-config step. 04:37:14 INFO - ##### 04:37:14 INFO - Running pre-action listener: _resource_record_pre_action 04:37:14 INFO - Running main action method: read_buildbot_config 04:37:14 INFO - Using buildbot properties: 04:37:14 INFO - { 04:37:14 INFO - "project": "", 04:37:14 INFO - "product": "firefox", 04:37:14 INFO - "script_repo_revision": "production", 04:37:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:37:14 INFO - "repository": "", 04:37:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:37:14 INFO - "buildid": "20160419032946", 04:37:14 INFO - "pgo_build": "False", 04:37:14 INFO - "basedir": "/builds/slave/test", 04:37:14 INFO - "buildnumber": 1420, 04:37:14 INFO - "slavename": "talos-linux64-ix-018", 04:37:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:37:14 INFO - "platform": "ubuntu64_hw", 04:37:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:37:14 INFO - "branch": "fx-team", 04:37:14 INFO - "repo_path": "integration/fx-team", 04:37:14 INFO - "revision": "29d7a174bdb4f63cb198b639d62a80fc6ea02dc6", 04:37:14 INFO - "stage_platform": "linux64", 04:37:14 INFO - "builduid": "888dd407cf58424d8f5448d914a222f8", 04:37:14 INFO - "slavebuilddir": "test" 04:37:14 INFO - } 04:37:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:37:14 INFO - Running post-action listener: _resource_record_post_action 04:37:14 INFO - ##### 04:37:14 INFO - ##### Running download-and-extract step. 04:37:14 INFO - ##### 04:37:14 INFO - Running pre-action listener: _resource_record_pre_action 04:37:14 INFO - Running main action method: download_and_extract 04:37:14 INFO - mkdir: /builds/slave/test/build/tests 04:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:14 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:25 INFO - Downloaded 1361 bytes. 04:37:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:37:25 INFO - Using the following test package requirements: 04:37:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:37:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:37:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:37:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'jsshell-linux-x86_64.zip'], 04:37:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:37:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:37:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:37:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:37:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:37:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:37:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:37:25 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')]} 04:37:25 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:36 INFO - Downloaded 22211033 bytes. 04:37:36 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'] 04:37:36 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 04:37:37 INFO - Return code: 0 04:37:37 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 04:37:37 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')]} 04:37:37 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:39 INFO - Downloaded 22211033 bytes. 04:37:39 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'] 04:37:39 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 04:37:40 INFO - Return code: 0 04:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:40 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:42 INFO - Downloaded 10845952 bytes. 04:37:42 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'] 04:37:42 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 04:37:42 INFO - Return code: 0 04:37:42 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')]} 04:37:42 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:44 INFO - Downloaded 54449573 bytes. 04:37:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:44 INFO - mkdir: /builds/slave/test/properties 04:37:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:44 INFO - Contents: 04:37:44 INFO - build_url:https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - Running post-action listener: set_extra_try_arguments 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running populate-webroot step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: populate_webroot 04:37:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:45 INFO - '--tppagecycles', 04:37:45 INFO - '7'], 04:37:45 INFO - 'tests': ['tsvgm']}}, 04:37:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s', 04:37:45 INFO - '--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}, 04:37:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}}, 04:37:45 INFO - 'talos.zip': {'path': '', 04:37:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running create-virtualenv step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: create_virtualenv 04:37:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:45 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 04:37:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:45 INFO - Using real prefix '/usr' 04:37:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:47 INFO - Installing pip.................done. 04:37:47 INFO - Return code: 0 04:37:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:47 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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:37:47 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 04:37:47 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 04:37:47 INFO - Using env: {'DISPLAY': ':0', 04:37:47 INFO - 'HOME': '/home/cltbld', 04:37:47 INFO - 'LANG': 'en_US.UTF-8', 04:37:47 INFO - 'LANGUAGE': 'en_US:en', 04:37:47 INFO - 'LOGNAME': 'cltbld', 04:37:47 INFO - 'MAIL': '/var/mail/cltbld', 04:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:47 INFO - 'MOZ_NO_REMOTE': '1', 04:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:47 INFO - 'NO_EM_RESTART': '1', 04:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:47 INFO - 'PWD': '/builds/slave/test', 04:37:47 INFO - 'SHELL': '/bin/bash', 04:37:47 INFO - 'SHLVL': '1', 04:37:47 INFO - 'TERM': 'linux', 04:37:47 INFO - 'TMOUT': '86400', 04:37:47 INFO - 'USER': 'cltbld', 04:37:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:47 INFO - '_': '/tools/buildbot/bin/python'} 04:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:48 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 04:37:48 INFO - Cleaning up... 04:37:48 INFO - Return code: 0 04:37:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:48 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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:37:48 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 04:37:48 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 04:37:48 INFO - Using env: {'DISPLAY': ':0', 04:37:48 INFO - 'HOME': '/home/cltbld', 04:37:48 INFO - 'LANG': 'en_US.UTF-8', 04:37:48 INFO - 'LANGUAGE': 'en_US:en', 04:37:48 INFO - 'LOGNAME': 'cltbld', 04:37:48 INFO - 'MAIL': '/var/mail/cltbld', 04:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:48 INFO - 'MOZ_NO_REMOTE': '1', 04:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:48 INFO - 'NO_EM_RESTART': '1', 04:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:48 INFO - 'PWD': '/builds/slave/test', 04:37:48 INFO - 'SHELL': '/bin/bash', 04:37:48 INFO - 'SHLVL': '1', 04:37:48 INFO - 'TERM': 'linux', 04:37:48 INFO - 'TMOUT': '86400', 04:37:48 INFO - 'USER': 'cltbld', 04:37:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:48 INFO - '_': '/tools/buildbot/bin/python'} 04:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:48 INFO - Downloading/unpacking psutil>=0.7.1 04:37:48 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 04:37:48 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 04:37:48 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 04:37:48 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 04:37:48 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 04:37:48 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 04:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:50 INFO - Installing collected packages: psutil 04:37:50 INFO - Running setup.py install for psutil 04:37:50 INFO - building 'psutil._psutil_linux' extension 04:37:50 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 04:37:50 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 04:37:50 INFO - building 'psutil._psutil_posix' extension 04:37:50 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 04:37:50 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 04:37:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:50 INFO - Successfully installed psutil 04:37:50 INFO - Cleaning up... 04:37:50 INFO - Return code: 0 04:37:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:50 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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:37:50 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 04:37:50 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 04:37:50 INFO - Using env: {'DISPLAY': ':0', 04:37:50 INFO - 'HOME': '/home/cltbld', 04:37:50 INFO - 'LANG': 'en_US.UTF-8', 04:37:50 INFO - 'LANGUAGE': 'en_US:en', 04:37:50 INFO - 'LOGNAME': 'cltbld', 04:37:50 INFO - 'MAIL': '/var/mail/cltbld', 04:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:50 INFO - 'MOZ_NO_REMOTE': '1', 04:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:50 INFO - 'NO_EM_RESTART': '1', 04:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:50 INFO - 'PWD': '/builds/slave/test', 04:37:50 INFO - 'SHELL': '/bin/bash', 04:37:50 INFO - 'SHLVL': '1', 04:37:50 INFO - 'TERM': 'linux', 04:37:50 INFO - 'TMOUT': '86400', 04:37:50 INFO - 'USER': 'cltbld', 04:37:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:50 INFO - '_': '/tools/buildbot/bin/python'} 04:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:51 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 04:37:51 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 04:37:51 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 04:37:51 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 04:37:51 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 04:37:51 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 04:37:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:37:53 INFO - Installing collected packages: mozsystemmonitor 04:37:53 INFO - Running setup.py install for mozsystemmonitor 04:37:53 INFO - Successfully installed mozsystemmonitor 04:37:53 INFO - Cleaning up... 04:37:53 INFO - Return code: 0 04:37:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', '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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37: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 blobuploader==1.2.4 04:37:53 INFO - Using env: {'DISPLAY': ':0', 04:37:53 INFO - 'HOME': '/home/cltbld', 04:37:53 INFO - 'LANG': 'en_US.UTF-8', 04:37:53 INFO - 'LANGUAGE': 'en_US:en', 04:37:53 INFO - 'LOGNAME': 'cltbld', 04:37:53 INFO - 'MAIL': '/var/mail/cltbld', 04:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:53 INFO - 'MOZ_NO_REMOTE': '1', 04:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:53 INFO - 'NO_EM_RESTART': '1', 04:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:53 INFO - 'PWD': '/builds/slave/test', 04:37:53 INFO - 'SHELL': '/bin/bash', 04:37:53 INFO - 'SHLVL': '1', 04:37:53 INFO - 'TERM': 'linux', 04:37:53 INFO - 'TMOUT': '86400', 04:37:53 INFO - 'USER': 'cltbld', 04:37:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:53 INFO - '_': '/tools/buildbot/bin/python'} 04:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 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 04:37:55 INFO - Downloading docopt-0.6.1.tar.gz 04:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:56 INFO - Running setup.py install for blobuploader 04:37:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:56 INFO - Running setup.py install for requests 04:37:56 INFO - Running setup.py install for docopt 04:37:56 INFO - Successfully installed blobuploader requests docopt 04:37:56 INFO - Cleaning up... 04:37:56 INFO - Return code: 0 04:37:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:37:56 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 04:37:56 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 04:37:56 INFO - Using env: {'DISPLAY': ':0', 04:37:56 INFO - 'HOME': '/home/cltbld', 04:37:56 INFO - 'LANG': 'en_US.UTF-8', 04:37:56 INFO - 'LANGUAGE': 'en_US:en', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MAIL': '/var/mail/cltbld', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SHLVL': '1', 04:37:56 INFO - 'TERM': 'linux', 04:37:56 INFO - 'TMOUT': '86400', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - '_': '/tools/buildbot/bin/python'} 04:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:56 INFO - Running setup.py (path:/tmp/pip-jnf1JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:56 INFO - Running setup.py (path:/tmp/pip-WY4488-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:57 INFO - Running setup.py (path:/tmp/pip-lkvn8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:57 INFO - Running setup.py (path:/tmp/pip-8gLYYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:57 INFO - Running setup.py (path:/tmp/pip-7gqjZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:57 INFO - Running setup.py (path:/tmp/pip-GqMhiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:57 INFO - Running setup.py (path:/tmp/pip-CtjRBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:57 INFO - Running setup.py (path:/tmp/pip-gc8QzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:57 INFO - Running setup.py (path:/tmp/pip-9PhEOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:57 INFO - Running setup.py (path:/tmp/pip-HBEOl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:57 INFO - Running setup.py (path:/tmp/pip-fWt2Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:57 INFO - Running setup.py (path:/tmp/pip-PJcLIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:57 INFO - Running setup.py (path:/tmp/pip-5gAKTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:57 INFO - Running setup.py (path:/tmp/pip-o47tcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:57 INFO - Running setup.py (path:/tmp/pip-rPgsZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:57 INFO - Running setup.py (path:/tmp/pip-aMzteO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:58 INFO - Running setup.py (path:/tmp/pip-xkD3Yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:58 INFO - Running setup.py install for manifestparser 04:37:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozcrash 04:37:58 INFO - Running setup.py install for mozdebug 04:37:58 INFO - Running setup.py install for mozdevice 04:37:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozfile 04:37:58 INFO - Running setup.py install for mozhttpd 04:37:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozinfo 04:37:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozInstall 04:37:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:58 INFO - Running setup.py install for mozleak 04:37:58 INFO - Running setup.py install for mozlog 04:37:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Running setup.py install for moznetwork 04:37:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Running setup.py install for mozprocess 04:37:59 INFO - Running setup.py install for mozprofile 04:37:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Running setup.py install for mozrunner 04:37:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Running setup.py install for mozscreenshot 04:37:59 INFO - Running setup.py install for moztest 04:37:59 INFO - Running setup.py install for mozversion 04:37:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:59 INFO - Cleaning up... 04:37:59 INFO - Return code: 0 04:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:59 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')]} 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:59 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')]} 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:59 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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:37:59 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 04:37:59 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 04:37:59 INFO - Using env: {'DISPLAY': ':0', 04:37:59 INFO - 'HOME': '/home/cltbld', 04:37:59 INFO - 'LANG': 'en_US.UTF-8', 04:37:59 INFO - 'LANGUAGE': 'en_US:en', 04:37:59 INFO - 'LOGNAME': 'cltbld', 04:37:59 INFO - 'MAIL': '/var/mail/cltbld', 04:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:59 INFO - 'MOZ_NO_REMOTE': '1', 04:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:59 INFO - 'NO_EM_RESTART': '1', 04:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:59 INFO - 'PWD': '/builds/slave/test', 04:37:59 INFO - 'SHELL': '/bin/bash', 04:37:59 INFO - 'SHLVL': '1', 04:37:59 INFO - 'TERM': 'linux', 04:37:59 INFO - 'TMOUT': '86400', 04:37:59 INFO - 'USER': 'cltbld', 04:37:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:59 INFO - '_': '/tools/buildbot/bin/python'} 04:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:00 INFO - Running setup.py (path:/tmp/pip-cPnOFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:00 INFO - Running setup.py (path:/tmp/pip-0E6dwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:00 INFO - Running setup.py (path:/tmp/pip-l5GDJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:00 INFO - Running setup.py (path:/tmp/pip-gnvTqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:00 INFO - Running setup.py (path:/tmp/pip-qGXQsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:00 INFO - Running setup.py (path:/tmp/pip-UyS817-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:00 INFO - Running setup.py (path:/tmp/pip-iOCmKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:00 INFO - Running setup.py (path:/tmp/pip-7oe_Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:00 INFO - Running setup.py (path:/tmp/pip-2EyvN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:00 INFO - Running setup.py (path:/tmp/pip-pxh77r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:00 INFO - Running setup.py (path:/tmp/pip-a2qWx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:00 INFO - Running setup.py (path:/tmp/pip-hl0fpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:00 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)) 04:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:00 INFO - Running setup.py (path:/tmp/pip-79LYcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:01 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)) 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:01 INFO - Running setup.py (path:/tmp/pip-vnwYAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:01 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)) 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:01 INFO - Running setup.py (path:/tmp/pip-XUhc7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:01 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)) 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:01 INFO - Running setup.py (path:/tmp/pip-e7QpHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:01 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)) 04:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:01 INFO - Running setup.py (path:/tmp/pip-ACjzDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 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)) 04:38:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:03 INFO - Downloading blessings-1.6.tar.gz 04:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:03 INFO - Installing collected packages: blessings 04:38:03 INFO - Running setup.py install for blessings 04:38:03 INFO - Successfully installed blessings 04:38:03 INFO - Cleaning up... 04:38:03 INFO - Return code: 0 04:38:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:03 INFO - Reading from file tmpfile_stdout 04:38:03 INFO - Current package versions: 04:38:03 INFO - argparse == 1.2.1 04:38:03 INFO - blessings == 1.6 04:38:03 INFO - blobuploader == 1.2.4 04:38:03 INFO - docopt == 0.6.1 04:38:03 INFO - manifestparser == 1.1 04:38:03 INFO - mozInstall == 1.12 04:38:03 INFO - mozcrash == 0.17 04:38:03 INFO - mozdebug == 0.1 04:38:03 INFO - mozdevice == 0.48 04:38:03 INFO - mozfile == 1.2 04:38:03 INFO - mozhttpd == 0.7 04:38:03 INFO - mozinfo == 0.9 04:38:03 INFO - mozleak == 0.1 04:38:03 INFO - mozlog == 3.1 04:38:03 INFO - moznetwork == 0.27 04:38:03 INFO - mozprocess == 0.22 04:38:03 INFO - mozprofile == 0.28 04:38:03 INFO - mozrunner == 6.11 04:38:03 INFO - mozscreenshot == 0.1 04:38:03 INFO - mozsystemmonitor == 0.0 04:38:03 INFO - moztest == 0.7 04:38:03 INFO - mozversion == 1.4 04:38:03 INFO - psutil == 3.1.1 04:38:03 INFO - requests == 1.2.3 04:38:03 INFO - wsgiref == 0.1.2 04:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:03 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 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:38:03 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 04:38:03 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 04:38:03 INFO - Using env: {'DISPLAY': ':0', 04:38:03 INFO - 'HOME': '/home/cltbld', 04:38:03 INFO - 'LANG': 'en_US.UTF-8', 04:38:03 INFO - 'LANGUAGE': 'en_US:en', 04:38:03 INFO - 'LOGNAME': 'cltbld', 04:38:03 INFO - 'MAIL': '/var/mail/cltbld', 04:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:03 INFO - 'MOZ_NO_REMOTE': '1', 04:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:03 INFO - 'NO_EM_RESTART': '1', 04:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:03 INFO - 'PWD': '/builds/slave/test', 04:38:03 INFO - 'SHELL': '/bin/bash', 04:38:03 INFO - 'SHLVL': '1', 04:38:03 INFO - 'TERM': 'linux', 04:38:03 INFO - 'TMOUT': '86400', 04:38:03 INFO - 'USER': 'cltbld', 04:38:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:03 INFO - '_': '/tools/buildbot/bin/python'} 04:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 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)) 04:38:03 INFO - Cleaning up... 04:38:03 INFO - Return code: 0 04:38:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:38:03 INFO - Using env: {'DISPLAY': ':0', 04:38:03 INFO - 'HOME': '/home/cltbld', 04:38:03 INFO - 'LANG': 'en_US.UTF-8', 04:38:03 INFO - 'LANGUAGE': 'en_US:en', 04:38:03 INFO - 'LOGNAME': 'cltbld', 04:38:03 INFO - 'MAIL': '/var/mail/cltbld', 04:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:03 INFO - 'MOZ_NO_REMOTE': '1', 04:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:03 INFO - 'NO_EM_RESTART': '1', 04:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:03 INFO - 'PWD': '/builds/slave/test', 04:38:03 INFO - 'SHELL': '/bin/bash', 04:38:03 INFO - 'SHLVL': '1', 04:38:03 INFO - 'TERM': 'linux', 04:38:03 INFO - 'TMOUT': '86400', 04:38:03 INFO - 'USER': 'cltbld', 04:38:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:03 INFO - '_': '/tools/buildbot/bin/python'} 04:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:04 INFO - Downloading/unpacking jsonschema 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:06 INFO - warning: no files found matching '*.txt' 04:38:06 INFO - no previously-included directories found matching 'build' 04:38:06 INFO - no previously-included directories found matching 'dist' 04:38:06 INFO - no previously-included directories found matching '.git*' 04:38:06 INFO - Installing collected packages: jsonschema, functools32 04:38:06 INFO - Running setup.py install for functools32 04:38:06 INFO - warning: no files found matching '*.txt' 04:38:06 INFO - no previously-included directories found matching 'build' 04:38:06 INFO - no previously-included directories found matching 'dist' 04:38:06 INFO - no previously-included directories found matching '.git*' 04:38:06 INFO - Successfully installed jsonschema functools32 04:38:06 INFO - Cleaning up... 04:38:06 INFO - Return code: 0 04:38:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa40a0c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d755a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, '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-1461065319.464287-514348873', '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 04:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:38:06 INFO - Using env: {'DISPLAY': ':0', 04:38:06 INFO - 'HOME': '/home/cltbld', 04:38:06 INFO - 'LANG': 'en_US.UTF-8', 04:38:06 INFO - 'LANGUAGE': 'en_US:en', 04:38:06 INFO - 'LOGNAME': 'cltbld', 04:38:06 INFO - 'MAIL': '/var/mail/cltbld', 04:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:06 INFO - 'MOZ_NO_REMOTE': '1', 04:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:06 INFO - 'NO_EM_RESTART': '1', 04:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:06 INFO - 'PWD': '/builds/slave/test', 04:38:06 INFO - 'SHELL': '/bin/bash', 04:38:06 INFO - 'SHLVL': '1', 04:38:06 INFO - 'TERM': 'linux', 04:38:06 INFO - 'TMOUT': '86400', 04:38:06 INFO - 'USER': 'cltbld', 04:38:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:06 INFO - '_': '/tools/buildbot/bin/python'} 04:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:06 INFO - Downloading/unpacking flake8 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:09 INFO - no previously-included directories found matching 'docs/_build' 04:38:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:09 INFO - Running setup.py install for pep8 04:38:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:09 INFO - no previously-included directories found matching 'docs/_build' 04:38:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:09 INFO - Cleaning up... 04:38:09 INFO - Return code: 0 04:38:09 INFO - Running post-action listener: _resource_record_post_action 04:38:09 INFO - Running post-action listener: _start_resource_monitoring 04:38:09 INFO - Starting resource monitoring. 04:38:09 INFO - ##### 04:38:09 INFO - ##### Running install step. 04:38:09 INFO - ##### 04:38:09 INFO - Running pre-action listener: _resource_record_pre_action 04:38:09 INFO - Running main action method: install 04:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:09 INFO - Reading from file tmpfile_stdout 04:38:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:10 INFO - Reading from file tmpfile_stdout 04:38:10 INFO - Output received: 04:38:10 INFO - Usage: mozinstall [options] installer 04:38:10 INFO - Options: 04:38:10 INFO - -h, --help show this help message and exit 04:38:10 INFO - -d DEST, --destination=DEST 04:38:10 INFO - Directory to install application into. [default: 04:38:10 INFO - "/builds/slave/test"] 04:38:10 INFO - --app=APP Application being installed. [default: firefox] 04:38:10 INFO - mkdir: /builds/slave/test/build/application 04:38:10 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'] 04:38:10 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 04:38:25 INFO - Reading from file tmpfile_stdout 04:38:25 INFO - Output received: 04:38:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:38:25 INFO - Running post-action listener: _resource_record_post_action 04:38:25 INFO - ##### 04:38:25 INFO - ##### Running run-tests step. 04:38:25 INFO - ##### 04:38:25 INFO - Running pre-action listener: _resource_record_pre_action 04:38:25 INFO - Running main action method: run_tests 04:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:25 INFO - Python 2.7.3 04:38:25 INFO - Return code: 0 04:38:25 INFO - grabbing minidump binary from tooltool 04:38:25 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')]} 04:38:25 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 0x1e04410>, '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 0x1e05310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e057a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:25 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 04:38:25 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 04:38:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:25 INFO - Return code: 0 04:38:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:38:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:38:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:26 INFO - Return code: 0 04:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:38:26 INFO - Using env: {'DISPLAY': ':0', 04:38:26 INFO - 'HOME': '/home/cltbld', 04:38:26 INFO - 'LANG': 'en_US.UTF-8', 04:38:26 INFO - 'LANGUAGE': 'en_US:en', 04:38:26 INFO - 'LOGNAME': 'cltbld', 04:38:26 INFO - 'MAIL': '/var/mail/cltbld', 04:38:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:26 INFO - 'MOZ_NO_REMOTE': '1', 04:38:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:26 INFO - 'NO_EM_RESTART': '1', 04:38:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:26 INFO - 'PWD': '/builds/slave/test', 04:38:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:26 INFO - 'SHELL': '/bin/bash', 04:38:26 INFO - 'SHLVL': '1', 04:38:26 INFO - 'TERM': 'linux', 04:38:26 INFO - 'TMOUT': '86400', 04:38:26 INFO - 'USER': 'cltbld', 04:38:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461065319.464287-514348873', 04:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:26 INFO - '_': '/tools/buildbot/bin/python'} 04:38:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:38:26 INFO - mozversion application_buildid: 20160419032946 04:38:26 INFO - mozversion application_changeset: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 04:38:26 INFO - mozversion application_display_name: Nightly 04:38:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:26 INFO - mozversion application_name: Firefox 04:38:26 INFO - mozversion application_remotingname: firefox 04:38:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:38:26 INFO - mozversion application_vendor: Mozilla 04:38:26 INFO - mozversion application_version: 48.0a1 04:38:26 INFO - mozversion platform_buildid: 20160419032946 04:38:26 INFO - mozversion platform_changeset: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 04:38:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:38:26 INFO - mozversion platform_version: 48.0a1 04:38:26 INFO - using testdate: 1461065906 04:38:26 INFO - actual date: 1461065906 04:38:26 INFO - starting webserver on 'localhost:59983' 04:38:26 INFO - SUITE-START | Running 2 tests 04:38:26 INFO - TEST-START | dromaeo_css 04:38:26 INFO - operating with platform_type : linux_ 04:38:26 INFO - Initialising browser for dromaeo_css test... 04:38:26 INFO - TEST-INFO | started process 8606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu2cQL_/profile http://localhost:59983/getInfo.html) 04:38:31 INFO - PROCESS | 8606 | 04:38:31 INFO - PROCESS | 8606 | (process:8671): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:38:32 INFO - PROCESS | 8606 | __metrics Screen width/height:1600/1200 04:38:32 INFO - PROCESS | 8606 | colorDepth:24 04:38:32 INFO - PROCESS | 8606 | Browser inner width/height: 1024/697 04:38:32 INFO - PROCESS | 8606 | __metrics 04:38:33 ERROR - PROCESS | 8606 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:38:33 INFO - TEST-INFO | 8606: exit 0 04:38:33 INFO - Browser initialized. 04:38:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:33 INFO - TEST-INFO | started process 8722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu2cQL_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:35 INFO - PROCESS | 8722 | 04:38:35 INFO - PROCESS | 8722 | (process:8780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:38:45 INFO - PROCESS | 8722 | RSS: Main: 164585472 04:38:45 INFO - PROCESS | 8722 | 04:39:35 INFO - PROCESS | 8722 | 1461065975577 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] 04:41:47 INFO - PROCESS | 8722 | Cycle 1(1): loaded http://localhost:59983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59983/tests/dromaeo/cssquery-ext.html) 04:41:48 INFO - PROCESS | 8722 | RSS: Main: 168701952 04:41:48 INFO - PROCESS | 8722 | 04:44:50 INFO - PROCESS | 8722 | Cycle 1(1): loaded http://localhost:59983/tests/dromaeo/cssquery-ext.html (next: http://localhost:59983/tests/dromaeo/cssquery-jquery.html) 04:44:51 INFO - PROCESS | 8722 | RSS: Main: 165134336 04:44:51 INFO - PROCESS | 8722 | 04:47:52 INFO - PROCESS | 8722 | Cycle 1(1): loaded http://localhost:59983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59983/tests/dromaeo/cssquery-mootools.html) 04:47:53 INFO - PROCESS | 8722 | RSS: Main: 166576128 04:47:53 INFO - PROCESS | 8722 | 04:50:55 INFO - PROCESS | 8722 | Cycle 1(1): loaded http://localhost:59983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59983/tests/dromaeo/cssquery-prototype.html) 04:50:55 INFO - PROCESS | 8722 | RSS: Main: 164352000 04:50:55 INFO - PROCESS | 8722 | 04:53:58 INFO - PROCESS | 8722 | Cycle 1(1): loaded http://localhost:59983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59983/tests/dromaeo/cssquery-yui.html) 04:53:59 INFO - PROCESS | 8722 | RSS: Main: 165576704 04:53:59 INFO - PROCESS | 8722 | 04:57:01 INFO - PROCESS | 8722 | Cycle 1(1): loaded http://localhost:59983/tests/dromaeo/cssquery-yui.html (next: http://localhost:59983/tests/dromaeo/cssquery-dojo.html) 04:57:02 INFO - PROCESS | 8722 | RSS: Main: 167575552 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | __start_tp_report 04:57:02 INFO - PROCESS | 8722 | _x_x_mozilla_page_load 04:57:02 INFO - PROCESS | 8722 | _x_x_mozilla_page_load_details 04:57:02 INFO - PROCESS | 8722 | |i|pagename|runs| 04:57:02 INFO - PROCESS | 8722 | |0;dojo.html;2630.092618046774;2688.623592697024;2690.4350086481836;2746.491898998684;2752;4718.693284936477;4758.666893317469;4787.305840653104;4807.831725889595;4831.033793241349;4665.9766701166445;4779.426468823737;4793.041391721661;4804.375431193948;4823.155947709146;4399.186150562156;4445.199864024475;4471.061077173781;4486.820527178909;4535.977320113411;479.80298245409574;4284.528701842794;4346.84786032489;4353.564643535637;4362.607365337135;4398.516163222043;4409.559044095597;4419.337099435078;4429.15845989261;4437.735698664424;4384.934225986613;4415.690901636886;4416.447944006999;4425.7565833879125;4475.037866858608;4340.8480703175555;4396.054848207618;4412.691111622188;4432.84485043022;4454.955450445519;4695.577398034159;4710.693804902705;4718.197906355894;4723.7874295656775;4732.52674732524;4910.680805747615;5080.237964305346;5166.560842328407;5170.1986192140275;5173.896522069575;5150.381954165487;5183.974080129613;5201.661891977009;5204.089284375257;5252.789888404459;4785.49752276013;4823.131836269435;4829.082474329901;4849.078675051729;4895.143349913751;4948.282499037619;5173.405058418255;5223.059849227176;5308.946910530923;5400.054990376669;4990.451050384455;5011.373578302712;5020.49795020495;5033.748312584356;5065.949340506621;5104.157813960729;5117.616178786606;5119.539241468286;5120.539151476385;5166.509181627739;4894.510548945148;4987.750612469362;5061.949380506221;5062.417821950449;5080.009398167395;5102.311187989648;5102.515261050195;5103;5123.462036486189;5185.377754669464;4318.805653745589;4320.200762858818;4324.545922678073;4327.740335579812;4381.693281470267;3641.289948460025;3683.042408973686;3756.042209236627;3818.1409182933617;3886.591907849692;4502.459704835375;4514.571115744065;4540.841070562515;4541.137183935041;4549.840755573539;5136.4606716295;5151.871203219949;5156.303898973591;5168.689878607295;5208.322918020633;4383.189110014658;4442.755648439303;4473.4408198975125;4519.118771839526;4519.163954668331;4587.059652771174;4587.907586432923;4603.033362993809;4618.168729628632;4639.8936940807625;4802.423709154924;4813.422389313375;4816.012717392996;4816.157172494799;4861.611071114373;4985.451600323889;5086.6439349246675;5127.128388174094;5156.587473002226;5199.48005199477;4818.927716084331;4834.087255225062;4848;4863.756812159449;4892.143874821821;5056.82301119459;5083.87290317745;5092.930484598276;5098.97450512745;5148.510891465305;5039.47085556026;5076.416212135652;5144.331236939174;5161.019406312938;5180.48195180479;4965.702057876539;4991.126552853309;4993.725345106054;5005.549500544968;5034.4462109167225;4976.900461990812;4984.575822664402;4996.2505624156665;5000.924986125138;5007.39911210657;4879.804807807648;4880.658353915192;4891.682040667345;4906.533879281463;4949.985253023049;5028.84913452597;5034.899302014012;5037.848864534069;5048.192289233705;5095.082885080573;4764.094821983812;4819.1566475867285;4943.036107958914;4947.356843610308;4983.501649834988 04:57:02 INFO - PROCESS | 8722 | |1;ext.html;581.3169525807175;601.0083362451953;618.5762752514528;620.7672122953892;657.3919124809549;33252.16869578259;33888.830555847184;34177.658223417755;34310;34329.82835085824;34635.82682086592;34947;35182.12044698884;35276.2944741105;35282.647173528254;7574.84850302995;7722.420818438612;7726.575038372887;7727.884081738778;7739.2260773922435;7578.242175782405;7827;7836.2947334739865;7842.176571460001;7851.921480785205;7814.296713295802;7815.882761758578;7824.804379890491;7890.56601886896;7894.881576776353;7808.570528620923;7856.25365590268;7864.056313242419;7874.173211812792;7882.566458844762;7747.612619369065;7812.921870781276;7845.176256493043;7849.8037549061155;7858.921410785933;28600;34167.145821354665;34703.30593388118;34708;34850;2933.779966502521;2968.1095671298526;2996.310848504834;3122.5784519090084;3518.5074089627474;24011.39971500709;24855.751442485525;28224.15327540177;28946.565801512996;29001.274968125756;3333.949990750141;3364.142143753352;3370.359631669975;3452.7755695879687;3462.272922686239;203166;206179;206262;206972;208354.9999999985;52211.47788522142;52690;53023;53049.469505304456;53094;49299;61520.38479615146;63194.68402658049;63897;63962;13507.662308442368;13674.794878076837;13701.588952331445;13725.176489410667;13798.586042418743;10217.846732299022;10232.64185753495;10283.125934295518;10291.073803357735;10293.125084367912;17919.46241612754;18008.459746207634;18163.54591135206;18183.45449636513;18236.54408639768;6718.865622687519;6950.54821436605;6989.93010069903;7076.610786406694;7133.785986420416;898.1018981018981;933.4725879877848;965.0590674092704;976.472704739447;1047.6228557719214;25819.612705809428;25922.74077259241;25952.74047259541;26253.34366640849;26299.605505917043;961.0725649748026;986.5659109991581;992.9702108936743;1026.7689769801884;1113.7494063835572;13726.519571815139;14128.152310861176;14331;14364.712705745827;14548.054376465707;325857;333293;333395;333782;334280;49011;49499;49930.750346248766;49939;49942.50057499451;1195.1335281920713;1223.1682455929874;1230.2618428942742;1245.2715161630367;1251.8560365557896;25443.87278063598;26683;26782.59826102649;27004;27024.32439189036;40311.39532907067;46465.30302045404;47486.050278993534;47902.760486197345;48247.51752482571;309092;310937;311615;313524;314958;37535.62464375321;37735.433968491045;37969;38125.428118577685;38580.614193857706;41567.14708313866;42057.369139463546;42174;42235.7888210557;42575.574244257165;35041.474377884864;35175.296494070484;35568.28863422665;35967.820160900075;36182;34594.65405346015;35222.647773522964;35462;35640;35727.28545429129;35332.99060149421;35922.64077359193;36395.63604363923;36576;36794.816025919696;31178.376432471676;32257.774222578493;32861.50707739434;32959.67040329662;32982.175445614055;25531.617025745;25562.23313300604;25638.82070024069;25801.741982579933;25992.610110847974 04:57:02 INFO - PROCESS | 8722 | |2;jquery.html;383.7122158381215;384.78452066842567;386.6848518457457;397.05698964958225;397.4118304908737;15168.924155379222;16246.350145994162;16402.17989100543;16446.42437514687;16461.670766584662;15504.612384690388;16047;16489.752653710202;16628.33486660535;16639.50081497557;4972.527609877065;5097.923531147036;5098.541131298182;5138.7173705446185;5144.228365745131;4748.477667456577;5033.823816166435;5104.285400043978;5149.74251287436;5153.330067091273;4990.625703072266;5020.246962955568;5025.547700706936;5042.117629414856;5063.265826455162;4904.411470623512;5880.9411905880825;5883.382244864292;5889.911651325234;5897.8230653080045;5055.974720126413;5173.689578625294;5182.481751824825;5196.68819870809;5221.947780522184;11738.94130529342;11810;11973.521059157623;11978.341191234478;12002.339871307075;1787.8289720233267;1837.2926423326983;2046.1815273890413;2148.130007347027;2228.075348730275;9526;9533;11236.988671019648;12254.08094392924;12260.509579616804;1649.7772800671876;1678.2783403136646;1702.1489255372314;1732.3936622182262;1779.359430604981;64262.357376426575;66363;67380.6630966842;68141.3185868145;68227;9895.208383329316;10171.186305095574;10178.11704834608;10245.231607629308;10326.793464130675;13854.792178117335;13925.930370348084;13927.373268202955;13986.16083035021;14025.438982440588;6809.285025072395;7066.929330706627;7082.433405327562;7204.855902881913;7211.927880721126;6395;6401.263854656774;6495.3179916109075;6573.605583664996;6661.067450556926;4257.616814486649;4287.228298906164;4315.266404711207;4328.891777705582;4421.579949904753;1813.1296977450897;1835.431016384925;1841.9631607367778;1842.990785046093;1873.278787666758;920.3281604428804;927.1053433436631;935.3966691483955;971.7522031881825;974.7173319737338;16081.839181608268;16593.91703041477;16960.74558881618;17197.484075477754;17201.967881927125;852.497026754218;915.4324318922311;920.7329874336501;926.2034650200821;978.7259567321162;7799.3760499159935;9474.952625236967;9502.097300756417;9602.711918642452;9712.17446517054;363778;369694;372260;379816;381288;56025.43974560202;75144;77193.83940587084;77420.61289693516;79858;820.6881385073754;842.2588122452325;845.1252953193415;845.8477474054606;847.2501835875295;13916.165030098227;14265.857341426452;14361.497347592784;14433.566992990227;14546.345414456586;32375.190620234684;33598.66401335955;33739.83130084334;33775.3244935095;34465.48301775425;46270.53729462797;46377.53622463732;46415.303770444145;46494.53505464902;46896.53103469058;6231.096491008869;6591.011348297794;7741.922580774345;7892.4869883457395;7979.760607181794;10540.789184216426;11405;11649.941750291195;11843;12025.819612705642;10094.091531762177;10299.742506437398;10438.791224175626;10508.106810921157;10560.049595536131;10210.438425886647;10296.433696146783;10388.48057597102;10503.632372866912;10507.73730656709;10200.693979180636;10221.33561318512;10505.31715438494;10613.787724245627;10698.839517407401;6825.863482730417;6838.247792742894;6897.379235868796;6897.517173797986;7051.189113252041;7860.960695196487;10179.796404072025;10459.372437653765;10610.946945265534;10755.677329680122 04:57:02 INFO - PROCESS | 8722 | |3;mootools.html;1436.8419473857873;1486.925653717314;1631.8449747274012;1760.137532609022;1810.3663717698814;6696.062551242818;7597.164311925684;7660.119086305077;7896.170902055281;7914.129445760962;7632.542047477142;7653.31120199182;7681.039870016248;7718.691252349913;7721.420893433001;2195.7804219577993;2225.7440394354694;2235.7428895676962;2238.608243557379;2242.7981481666648;2188.2231807708195;2211.8009379155874;2259.1302348595827;2261.4685548895995;2261.5250797332496;2233.1737257214854;2263.25312646827;2263.581237471073;2265.728112626487;2285.874276914769;2221.4113259986116;2225.4436390902274;2229.7101376820992;2234.888255587214;2242.383344580237;2196.560687862434;2205.5368372641765;2206.4042708468623;2216.2021672198;2223.032980653421;7777.494462859896;7881.842363152705;7905.920940790634;7922.881156782653;7931.286184243388;4658.534146585314;4818.542238487338;4821.5178482151505;4826.107170173494;4833.32333473314;2812.7187281271913;2970.450466663674;2975.925601859949;2980.3890202508433;3008.368242669042;929.6327950459531;934.243262957007;954.3939598355025;958.2525630008604;965.2181732796387;10480;10577.524011419428;10585.788284234271;10610.575576976911;10664.253502254924;4225.619694227535;4251.9787401062795;4400;4432.977835110803;4468.486124095771;9049.77375565603;9071.228945539571;9092.772680683036;9104.954475227714;9112.772180695536;4780.235162374003;4796.664233503691;4821.5178482151505;4829.879253018632;4842.297866809364;3758.285925674113;4243;4385.890352741207;4385.956140438555;4400.845970391021;3792.222594368148;3807.1053302473897;3888.8055597220027;3897.2205558888336;3940.5074365704286;1251.474380760083;1260.212367270456;1270.491803278696;1276.5787290194214;1277.3613193403298;832.800127969283;835.3526017336612;837.2632083766247;851.9233269005696;857.5540718826176;5127.384713834289;5187.377514698261;5252.343457067866;5403.7838486460105;5458.808941687022;422.04752492903737;422.8646833013406;424.8576726796496;425.9637930775857;429.4052736959334;3589.7794749784675;3651.9817400912825;3681.4109742441615;3726.7763934163495;3759.9248015039548;9442.952785236168;9765.462899540593;9894.950525247472;9918.900810991941;9957.203423726085;9144.81710365789;9586.328956973084;9666.323357365058;9715.174210192214;9747.658831940847;6862.862742745117;6884.173899132136;6911.377975982085;6992.230854605989;7037.261087585832;5171.224316352577;5312.9734351328;5389.703566303734;5460.31746031746;5505.807296744595;8828.475753441648;8928.375013748975;8937.419067760575;8968.23769979559;8996.325275604226;9005.459672419676;9319.767005824637;9332.72001839946;9367.718968430958;9386.202172815114;6141.109539116714;6435.742570297136;6639.402453779183;6899.17209934811;6993.965030174817;7116.46626503004;7151.713931442684;7202.639868006474;7209.6034718091005;7219.530730502501;6340.619562826245;6343.116248941079;6437.839054023687;6616.437602803816;6660.367265109807;6401.167848179707;6426.29310775805;6542.738290468518;6576.901346479903;6716.630585317855;6093.421124993119;6210.378962103753;6211.316755156839;6223.190985171898;6250.0937364082865;4488.618467430305;4567.771611419482;4570.794314255933;4601.723896566216;4677.742724150068;4481.663875209307;4578.931316030195;4626.213543697512;4635.0498147878925;4667.929981050355 04:57:02 INFO - PROCESS | 8722 | |4;prototype.html;316.4193704552147;319.44576160361765;323.7636525336504;327.3355089168988;330.0214862931408;5371.543418809401;5378.408375078739;5393.191021346795;5420.783168673248;5474.178873169017;5362.24928510008;5367.302250707412;5369.463053694629;5376.623636345457;5377.327834020747;3918.4318273850204;4060.533038700558;4185;4195.685323600727;4198.622124008839;4169.332906734923;4187.1416359646355;4193.2242535130945;4200;4203.180379825935;4115.012397024708;4128.442660240874;4146.523149837762;4154.792260386968;4155.8753237402925;4045.9797701011603;4130.277201489742;4152.750834949913;4185.434966279544;4201.34879093741;3663.9267214655556;3671.467637192619;3673.1918977824835;3676.6507181817683;3678.3746763050076;5166.07010738067;5182.352205974254;5184.345036749083;5187.584993200535;5193.584513238932;4737.289406589005;4819.951800481986;4821.132196204681;4834.58905992991;4873.390826146731;5635.5773317001385;5651.1523271509195;5675.233843431167;5695.231143795576;5699.888521738263;4023.919521609581;4037.3338399164104;4039.4546736190828;4050.4936882889638;4050.7569545827346;5763.682997435139;5920.911186332209;5947.910781338283;6006.909896351558;6009.248843894513;4080.81636326366;4092.5907409258834;4100.958990410118;4112.177564487115;4121.835126594962;4168.541460439349;4170.645495132948;4173.353130264813;4178.26880295947;4181.832726690898;4641.698289611165;4758.143534163814;4766.809327626926;4773.37946067009;4775.856724298276;5623.803166889221;5629.887402251932;5632.718364081779;5640.802571909963;5642.4075472075665;1442.3941944383384;1451.2888684544498;1456.83974762776;1466.142306750563;1473.359088796377;890.6392910871108;978.5498670611598;981.474910922653;1001.6594357918343;1025.410389026313;4895.412550493892;4919.483454237254;4935.975320123376;4958.132326842788;4964.8758781030765;5790.449907258803;5800.8259752207505;5811.186433899257;5813.563982701315;5824.650520968756;4798.136335459651;4917.336159618406;4928.531789479994;4930.235813448921;4937.580305673986;3093.0875391759487;3102.100390886663;3119.594452721132;3120.0795765249304;3123.7504998000527;5376.220448035013;5396.109641909041;5403.2165336026055;5414.539764120015;5470.316210473691;5750.971245143747;5944.167816505693;5967.671778052249;5987.161797348374;5987.341392446828;5330.866728331823;5363.785448582013;5396.91904621431;5405;5424;5638.802641907678;5750.137479378127;5794.681292528951;5805.738741756547;5821.825345239649;5645.887082258249;5652.717364131695;5712.914306285326;5732.598718089694;5734.885302294014;5395.217693434509;5439.836804895859;5441.619086663895;5459.39946605881;5461.371942226695;3808.562015368268;4079.7960101994186;4095.4675892133832;4123.257813593582;4136.896577585464;5891.793787217427;5892.292924849045;5896.056630939029;5896.321922978741;5901;5650.3219613646625;5661.547076233809;5685.061964775766;5698.430156984268;5705.343885453226;5488.588355873405;5680.204771331934;5688.829335119953;5700.287464066992;5713.857153571028;5315.893682126413;5581.609287349846;5600.3356006352315;5601.80393686219;5612.803551875665;5490.258815059916;5644.887102258014;5658.858528536654;5702.34423041339;5719.971400142973;5546.278983732089;5585.3297604287745;5588.105903055492;5605.51453864718;5632.746526406403 04:57:02 INFO - PROCESS | 8722 | |5;yui.html;634.2959315160174;665.5574043261231;691.5939000422916;692.6675195905965;693.7259782385958;11623.418829058544;11678.824817627732;11711.824322635157;11765.176437649368;11876.28742275464;11094.112471002321;11505.769884602303;11708.063354931606;11708.648740537797;11723.0621550276;640.0431355124095;780.6487080813628;807.1283014344508;811.9512829230235;817.382875928676;813.5240884082789;813.556611646654;815.3925325632412;816.4488969945293;818.071488860145;850.5917159763318;855.9957200214021;857.7040920882285;858.7853036740814;862.8144948835999;844.8225872566768;846.289117141604;846.894138232724;847.1401527449643;853.5092321914892;627.0218459203656;627.0468887291337;627.9529035322369;630.0297541785644;632.1971096707202;12197.756044879141;12224.266544007389;12230.388480575935;12237.449314780857;12255.571055013032;12370.381480925918;12538.623841284776;12563.56027539041;12624.431900564497;12878.935605322007;11037.889621103766;11050.723731906766;11172.776544469147;11310.604128855533;11371.488283027202;4225.281702110648;4237.194932962727;4253.659707223414;4286.57134286572;4427.291633338683;44429.77785111086;44695;44882.77558612219;44888.551114488764;45036.3244551332;9300.8604870927;9340;9418.434893906388;9423.858642120374;9454.48000359973;16741.330346786235;16876.83123168777;16926.32294708198;16977.49067527976;17697.911510442365;6309.779157729457;6374.936250637527;6483.902741458882;6511.316311787289;6547.705353259114;3400.8777103555767;3403.030136411111;3414.914627134292;3424.8972530824117;3478.8300103631236;2800.551911694119;2843.090211132459;2876.964292854571;2880.15035564509;2891.79757416983;508.12907075025663;520.3079903728033;523.1472699499791;526.6655673647261;530.4880790037555;556.8858384031264;581.2879222951934;585.4496773033335;586.8855573163193;596.6360520082746;7642.96178519115;7678.424118191158;7766.534007959427;7839.216078392115;7946.404019698546;494.2141994229193;586.8268860686107;587.8060240120835;590.9451628842495;598.6228675934134;3643.872464463731;3775.5091838060875;3809.561900381492;3944.881653550398;4224.831006759757;44655.33017004748;45206.547934520895;45984;46303.5369646306;47970.5202947966;39537.40693889594;40039.19921601551;40498.39252411216;40667;40978.79510602428;37919.81040094837;39988.60011399907;40031;40655.1868962625;40692;8046.396520261121;8145.592720364077;8158.673653053811;8198.344132469269;8377.162283771575;28304.716952831033;28352.432951340445;28550;28570.857145714137;28718.138455846358;36111;37927;37965;38289;38365.232695346494;10552.947235263775;10574.524146413276;10680.57277708883;10827.621033263798;10848.837267441153;11645.47595358194;11803.645890623295;11832.408379580815;11919.940400297943;12123.818142728043;11084.778304433705;11108.833367499332;11181.496832642713;11276.774464510829;11284.266522676;10214.795704086026;10402.739931501774;10532.736681583021;10748.83876741865;10766.676999690022;10440.37357758537;11123.443827808738;11331.32012079278;11337.943310283395;11348.886511134782;8739.737807865775;9351.205147562534;9567.569459374206;9971.950140249251;10000.2999790014;8905.376623636283;9014.2788576915;9027.4132181408;9574;9593.136617704162 04:57:02 INFO - PROCESS | 8722 | __end_tp_report 04:57:02 INFO - PROCESS | 8722 | __start_cc_report 04:57:02 INFO - PROCESS | 8722 | _x_x_mozilla_cycle_collect,368 04:57:02 INFO - PROCESS | 8722 | __end_cc_report 04:57:02 INFO - PROCESS | 8722 | __startTimestamp1461067021998__endTimestamp 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | ------- Summary: start ------- 04:57:02 INFO - PROCESS | 8722 | Number of tests: 6 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | [#0] dojo.html Cycles:165 Average:4714.73 Median:4849.08 stddev:593.32 (12.2%) stddev-sans-first:572.16 04:57:02 INFO - PROCESS | 8722 | Values: 2630.1 2688.6 2690.4 2746.5 2752.0 4718.7 4758.7 4787.3 4807.8 4831.0 4666.0 4779.4 4793.0 4804.4 4823.2 4399.2 4445.2 4471.1 4486.8 4536.0 479.8 4284.5 4346.8 4353.6 4362.6 4398.5 4409.6 4419.3 4429.2 4437.7 4384.9 4415.7 4416.4 4425.8 4475.0 4340.8 4396.1 4412.7 4432.8 4455.0 4695.6 4710.7 4718.2 4723.8 4732.5 4910.7 5080.2 5166.6 5170.2 5173.9 5150.4 5184.0 5201.7 5204.1 5252.8 4785.5 4823.1 4829.1 4849.1 4895.1 4948.3 5173.4 5223.1 5308.9 5400.1 4990.5 5011.4 5020.5 5033.7 5065.9 5104.2 5117.6 5119.5 5120.5 5166.5 4894.5 4987.8 5061.9 5062.4 5080.0 5102.3 5102.5 5103.0 5123.5 5185.4 4318.8 4320.2 4324.5 4327.7 4381.7 3641.3 3683.0 3756.0 3818.1 3886.6 4502.5 4514.6 4540.8 4541.1 4549.8 5136.5 5151.9 5156.3 5168.7 5208.3 4383.2 4442.8 4473.4 4519.1 4519.2 4587.1 4587.9 4603.0 4618.2 4639.9 4802.4 4813.4 4816.0 4816.2 4861.6 4985.5 5086.6 5127.1 5156.6 5199.5 4818.9 4834.1 4848.0 4863.8 4892.1 5056.8 5083.9 5092.9 5099.0 5148.5 5039.5 5076.4 5144.3 5161.0 5180.5 4965.7 4991.1 4993.7 5005.5 5034.4 4976.9 4984.6 4996.3 5000.9 5007.4 4879.8 4880.7 4891.7 4906.5 4950.0 5028.8 5034.9 5037.8 5048.2 5095.1 4764.1 4819.2 4943.0 4947.4 4983.5 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | [#1] ext.html Cycles:180 Average:44426.26 Median:35108.39 stddev:75818.00 (216.0%) stddev-sans-first:75959.22 04:57:02 INFO - PROCESS | 8722 | Values: 581.3 601.0 618.6 620.8 657.4 33252.2 33888.8 34177.7 34310.0 34329.8 34635.8 34947.0 35182.1 35276.3 35282.6 7574.8 7722.4 7726.6 7727.9 7739.2 7578.2 7827.0 7836.3 7842.2 7851.9 7814.3 7815.9 7824.8 7890.6 7894.9 7808.6 7856.3 7864.1 7874.2 7882.6 7747.6 7812.9 7845.2 7849.8 7858.9 28600.0 34167.1 34703.3 34708.0 34850.0 2933.8 2968.1 2996.3 3122.6 3518.5 24011.4 24855.8 28224.2 28946.6 29001.3 3333.9 3364.1 3370.4 3452.8 3462.3 203166.0 206179.0 206262.0 206972.0 208355.0 52211.5 52690.0 53023.0 53049.5 53094.0 49299.0 61520.4 63194.7 63897.0 63962.0 13507.7 13674.8 13701.6 13725.2 13798.6 10217.8 10232.6 10283.1 10291.1 10293.1 17919.5 18008.5 18163.5 18183.5 18236.5 6718.9 6950.5 6989.9 7076.6 7133.8 898.1 933.5 965.1 976.5 1047.6 25819.6 25922.7 25952.7 26253.3 26299.6 961.1 986.6 993.0 1026.8 1113.7 13726.5 14128.2 14331.0 14364.7 14548.1 325857.0 333293.0 333395.0 333782.0 334280.0 49011.0 49499.0 49930.8 49939.0 49942.5 1195.1 1223.2 1230.3 1245.3 1251.9 25443.9 26683.0 26782.6 27004.0 27024.3 40311.4 46465.3 47486.1 47902.8 48247.5 309092.0 310937.0 311615.0 313524.0 314958.0 37535.6 37735.4 37969.0 38125.4 38580.6 41567.1 42057.4 42174.0 42235.8 42575.6 35041.5 35175.3 35568.3 35967.8 36182.0 34594.7 35222.6 35462.0 35640.0 35727.3 35333.0 35922.6 36395.6 36576.0 36794.8 31178.4 32257.8 32861.5 32959.7 32982.2 25531.6 25562.2 25638.8 25801.7 25992.6 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | [#2] jquery.html Cycles:180 Average:23127.64 Median:2327.51 stddev:61624.98 (2647.7%) stddev-sans-first:61774.19 04:57:02 INFO - PROCESS | 8722 | Values: 383.7 384.8 386.7 397.1 397.4 15168.9 16246.4 16402.2 16446.4 16461.7 15504.6 16047.0 16489.8 16628.3 16639.5 4972.5 5097.9 5098.5 5138.7 5144.2 4748.5 5033.8 5104.3 5149.7 5153.3 4990.6 5020.2 5025.5 5042.1 5063.3 4904.4 5880.9 5883.4 5889.9 5897.8 5056.0 5173.7 5182.5 5196.7 5221.9 11738.9 11810.0 11973.5 11978.3 12002.3 1787.8 1837.3 2046.2 2148.1 2228.1 9526.0 9533.0 11237.0 12254.1 12260.5 1649.8 1678.3 1702.1 1732.4 1779.4 64262.4 66363.0 67380.7 68141.3 68227.0 9895.2 10171.2 10178.1 10245.2 10326.8 13854.8 13925.9 13927.4 13986.2 14025.4 6809.3 7066.9 7082.4 7204.9 7211.9 6395.0 6401.3 6495.3 6573.6 6661.1 4257.6 4287.2 4315.3 4328.9 4421.6 1813.1 1835.4 1842.0 1843.0 1873.3 920.3 927.1 935.4 971.8 974.7 16081.8 16593.9 16960.7 17197.5 17202.0 852.5 915.4 920.7 926.2 978.7 7799.4 9475.0 9502.1 9602.7 9712.2 363778.0 369694.0 372260.0 379816.0 381288.0 56025.4 75144.0 77193.8 77420.6 79858.0 820.7 842.3 845.1 845.8 847.3 13916.2 14265.9 14361.5 14433.6 14546.3 32375.2 33598.7 33739.8 33775.3 34465.5 46270.5 46377.5 46415.3 46494.5 46896.5 6231.1 6591.0 7741.9 7892.5 7979.8 10540.8 11405.0 11649.9 11843.0 12025.8 10094.1 10299.7 10438.8 10508.1 10560.0 10210.4 10296.4 10388.5 10503.6 10507.7 10200.7 10221.3 10505.3 10613.8 10698.8 6825.9 6838.2 6897.4 6897.5 7051.2 7861.0 10179.8 10459.4 10610.9 10755.7 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | [#3] mootools.html Cycles:180 Average:5142.26 Median:5149.30 stddev:2854.30 (55.4%) stddev-sans-first:2848.73 04:57:02 INFO - PROCESS | 8722 | Values: 1436.8 1486.9 1631.8 1760.1 1810.4 6696.1 7597.2 7660.1 7896.2 7914.1 7632.5 7653.3 7681.0 7718.7 7721.4 2195.8 2225.7 2235.7 2238.6 2242.8 2188.2 2211.8 2259.1 2261.5 2261.5 2233.2 2263.3 2263.6 2265.7 2285.9 2221.4 2225.4 2229.7 2234.9 2242.4 2196.6 2205.5 2206.4 2216.2 2223.0 7777.5 7881.8 7905.9 7922.9 7931.3 4658.5 4818.5 4821.5 4826.1 4833.3 2812.7 2970.5 2975.9 2980.4 3008.4 929.6 934.2 954.4 958.3 965.2 10480.0 10577.5 10585.8 10610.6 10664.3 4225.6 4252.0 4400.0 4433.0 4468.5 9049.8 9071.2 9092.8 9105.0 9112.8 4780.2 4796.7 4821.5 4829.9 4842.3 3758.3 4243.0 4385.9 4386.0 4400.8 3792.2 3807.1 3888.8 3897.2 3940.5 1251.5 1260.2 1270.5 1276.6 1277.4 832.8 835.4 837.3 851.9 857.6 5127.4 5187.4 5252.3 5403.8 5458.8 422.0 422.9 424.9 426.0 429.4 3589.8 3652.0 3681.4 3726.8 3759.9 9443.0 9765.5 9895.0 9918.9 9957.2 9144.8 9586.3 9666.3 9715.2 9747.7 6862.9 6884.2 6911.4 6992.2 7037.3 5171.2 5313.0 5389.7 5460.3 5505.8 8828.5 8928.4 8937.4 8968.2 8996.3 9005.5 9319.8 9332.7 9367.7 9386.2 6141.1 6435.7 6639.4 6899.2 6994.0 7116.5 7151.7 7202.6 7209.6 7219.5 6340.6 6343.1 6437.8 6616.4 6660.4 6401.2 6426.3 6542.7 6576.9 6716.6 6093.4 6210.4 6211.3 6223.2 6250.1 4488.6 4567.8 4570.8 4601.7 4677.7 4481.7 4578.9 4626.2 4635.0 4667.9 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | [#4] prototype.html Cycles:180 Average:4681.18 Median:5365.54 stddev:1364.09 (25.4%) stddev-sans-first:1328.00 04:57:02 INFO - PROCESS | 8722 | Values: 316.4 319.4 323.8 327.3 330.0 5371.5 5378.4 5393.2 5420.8 5474.2 5362.2 5367.3 5369.5 5376.6 5377.3 3918.4 4060.5 4185.0 4195.7 4198.6 4169.3 4187.1 4193.2 4200.0 4203.2 4115.0 4128.4 4146.5 4154.8 4155.9 4046.0 4130.3 4152.8 4185.4 4201.3 3663.9 3671.5 3673.2 3676.7 3678.4 5166.1 5182.4 5184.3 5187.6 5193.6 4737.3 4820.0 4821.1 4834.6 4873.4 5635.6 5651.2 5675.2 5695.2 5699.9 4023.9 4037.3 4039.5 4050.5 4050.8 5763.7 5920.9 5947.9 6006.9 6009.2 4080.8 4092.6 4101.0 4112.2 4121.8 4168.5 4170.6 4173.4 4178.3 4181.8 4641.7 4758.1 4766.8 4773.4 4775.9 5623.8 5629.9 5632.7 5640.8 5642.4 1442.4 1451.3 1456.8 1466.1 1473.4 890.6 978.5 981.5 1001.7 1025.4 4895.4 4919.5 4936.0 4958.1 4964.9 5790.4 5800.8 5811.2 5813.6 5824.7 4798.1 4917.3 4928.5 4930.2 4937.6 3093.1 3102.1 3119.6 3120.1 3123.8 5376.2 5396.1 5403.2 5414.5 5470.3 5751.0 5944.2 5967.7 5987.2 5987.3 5330.9 5363.8 5396.9 5405.0 5424.0 5638.8 5750.1 5794.7 5805.7 5821.8 5645.9 5652.7 5712.9 5732.6 5734.9 5395.2 5439.8 5441.6 5459.4 5461.4 3808.6 4079.8 4095.5 4123.3 4136.9 5891.8 5892.3 5896.1 5896.3 5901.0 5650.3 5661.5 5685.1 5698.4 5705.3 5488.6 5680.2 5688.8 5700.3 5713.9 5315.9 5581.6 5600.3 5601.8 5612.8 5490.3 5644.9 5658.9 5702.3 5720.0 5546.3 5585.3 5588.1 5605.5 5632.7 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - PROCESS | 8722 | [#5] yui.html Cycles:180 Average:12228.86 Median:4225.06 stddev:13262.66 (313.9%) stddev-sans-first:13271.28 04:57:02 INFO - PROCESS | 8722 | Values: 634.3 665.6 691.6 692.7 693.7 11623.4 11678.8 11711.8 11765.2 11876.3 11094.1 11505.8 11708.1 11708.6 11723.1 640.0 780.6 807.1 812.0 817.4 813.5 813.6 815.4 816.4 818.1 850.6 856.0 857.7 858.8 862.8 844.8 846.3 846.9 847.1 853.5 627.0 627.0 628.0 630.0 632.2 12197.8 12224.3 12230.4 12237.4 12255.6 12370.4 12538.6 12563.6 12624.4 12878.9 11037.9 11050.7 11172.8 11310.6 11371.5 4225.3 4237.2 4253.7 4286.6 4427.3 44429.8 44695.0 44882.8 44888.6 45036.3 9300.9 9340.0 9418.4 9423.9 9454.5 16741.3 16876.8 16926.3 16977.5 17697.9 6309.8 6374.9 6483.9 6511.3 6547.7 3400.9 3403.0 3414.9 3424.9 3478.8 2800.6 2843.1 2877.0 2880.2 2891.8 508.1 520.3 523.1 526.7 530.5 556.9 581.3 585.4 586.9 596.6 7643.0 7678.4 7766.5 7839.2 7946.4 494.2 586.8 587.8 590.9 598.6 3643.9 3775.5 3809.6 3944.9 4224.8 44655.3 45206.5 45984.0 46303.5 47970.5 39537.4 40039.2 40498.4 40667.0 40978.8 37919.8 39988.6 40031.0 40655.2 40692.0 8046.4 8145.6 8158.7 8198.3 8377.2 28304.7 28352.4 28550.0 28570.9 28718.1 36111.0 37927.0 37965.0 38289.0 38365.2 10552.9 10574.5 10680.6 10827.6 10848.8 11645.5 11803.6 11832.4 11919.9 12123.8 11084.8 11108.8 11181.5 11276.8 11284.3 10214.8 10402.7 10532.7 10748.8 10766.7 10440.4 11123.4 11331.3 11337.9 11348.9 8739.7 9351.2 9567.6 9972.0 10000.3 8905.4 9014.3 9027.4 9574.0 9593.1 04:57:02 INFO - PROCESS | 8722 | -------- Summary: end -------- 04:57:02 INFO - PROCESS | 8722 | 04:57:02 INFO - TEST-INFO | 8722: exit 0 04:57:02 INFO - TEST-OK | dromaeo_css | took 1115714ms 04:57:02 INFO - TEST-START | kraken 04:57:02 INFO - operating with platform_type : linux_ 04:57:02 INFO - Initialising browser for kraken test... 04:57:02 INFO - TEST-INFO | started process 8954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZarx3/profile http://localhost:59983/getInfo.html) 04:57:06 INFO - PROCESS | 8954 | 04:57:06 INFO - PROCESS | 8954 | (process:9024): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:57:07 INFO - PROCESS | 8954 | __metrics Screen width/height:1600/1200 04:57:07 INFO - PROCESS | 8954 | colorDepth:24 04:57:07 INFO - PROCESS | 8954 | Browser inner width/height: 1024/697 04:57:07 INFO - PROCESS | 8954 | __metrics 04:57:08 ERROR - PROCESS | 8954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:57:09 INFO - TEST-INFO | 8954: exit 0 04:57:09 INFO - Browser initialized. 04:57:09 INFO - Running cycle 1/1 for kraken test... 04:57:09 INFO - TEST-INFO | started process 9075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDZarx3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:11 INFO - PROCESS | 9075 | 04:57:11 INFO - PROCESS | 9075 | (process:9133): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:57:21 INFO - PROCESS | 9075 | RSS: Main: 164515840 04:57:21 INFO - PROCESS | 9075 | 04:57:23 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59983/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:24 INFO - PROCESS | 9075 | RSS: Main: 168800256 04:57:24 INFO - PROCESS | 9075 | 04:57:27 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59983/tests/kraken/driver.html?testName=audio-dft) 04:57:28 INFO - PROCESS | 9075 | RSS: Main: 172507136 04:57:28 INFO - PROCESS | 9075 | 04:57:31 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59983/tests/kraken/driver.html?testName=audio-fft) 04:57:31 INFO - PROCESS | 9075 | RSS: Main: 164364288 04:57:31 INFO - PROCESS | 9075 | 04:57:33 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59983/tests/kraken/driver.html?testName=audio-oscillator) 04:57:34 INFO - PROCESS | 9075 | RSS: Main: 165646336 04:57:34 INFO - PROCESS | 9075 | 04:57:36 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:37 INFO - PROCESS | 9075 | RSS: Main: 165310464 04:57:37 INFO - PROCESS | 9075 | 04:57:40 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59983/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:41 INFO - PROCESS | 9075 | RSS: Main: 165539840 04:57:41 INFO - PROCESS | 9075 | 04:57:44 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59983/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:45 INFO - PROCESS | 9075 | RSS: Main: 163459072 04:57:45 INFO - PROCESS | 9075 | 04:57:48 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59983/tests/kraken/driver.html?testName=json-parse-financial) 04:57:48 INFO - PROCESS | 9075 | RSS: Main: 164184064 04:57:48 INFO - PROCESS | 9075 | 04:57:50 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:51 INFO - PROCESS | 9075 | RSS: Main: 164327424 04:57:51 INFO - PROCESS | 9075 | 04:57:53 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:53 INFO - PROCESS | 9075 | RSS: Main: 164438016 04:57:53 INFO - PROCESS | 9075 | 04:57:55 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:56 INFO - PROCESS | 9075 | RSS: Main: 164732928 04:57:56 INFO - PROCESS | 9075 | 04:57:59 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:00 INFO - PROCESS | 9075 | RSS: Main: 165175296 04:58:00 INFO - PROCESS | 9075 | 04:58:03 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:03 INFO - PROCESS | 9075 | RSS: Main: 164954112 04:58:03 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | Cycle 1(1): loaded http://localhost:59983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59983/tests/kraken/driver.html?testName=ai-astar) 04:58:05 INFO - PROCESS | 9075 | RSS: Main: 166334464 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | __start_tp_report 04:58:05 INFO - PROCESS | 9075 | _x_x_mozilla_page_load 04:58:05 INFO - PROCESS | 9075 | _x_x_mozilla_page_load_details 04:58:05 INFO - PROCESS | 9075 | |i|pagename|runs| 04:58:05 INFO - PROCESS | 9075 | |0;ai-astar;113;107;112;113;113;124;112;112;114;113 04:58:05 INFO - PROCESS | 9075 | |1;audio-beat-detection;162;138;167;173;138;166;168;138;189;140 04:58:05 INFO - PROCESS | 9075 | |2;audio-dft;161;164;162;167;173;162;164;161;167;162 04:58:05 INFO - PROCESS | 9075 | |3;audio-fft;76;74;77;155;79;77;75;75;149;75 04:58:05 INFO - PROCESS | 9075 | |4;audio-oscillator;94;94;150;95;94;96;138;93;94;142 04:58:05 INFO - PROCESS | 9075 | |5;imaging-gaussian-blur;117;118;117;118;118;117;118;117;120;118 04:58:05 INFO - PROCESS | 9075 | |6;imaging-darkroom;147;148;150;147;146;146;147;147;147;146 04:58:05 INFO - PROCESS | 9075 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;95;96 04:58:05 INFO - PROCESS | 9075 | |8;json-parse-financial;65;64;64;63;64;64;63;82;63;62 04:58:05 INFO - PROCESS | 9075 | |9;json-stringify-tinderbox;67;65;65;64;66;65;65;65;65;66 04:58:05 INFO - PROCESS | 9075 | |10;stanford-crypto-aes;88;79;79;82;87;80;80;81;81;79 04:58:05 INFO - PROCESS | 9075 | |11;stanford-crypto-ccm;134;141;134;139;145;134;140;136;174;146 04:58:05 INFO - PROCESS | 9075 | |12;stanford-crypto-pbkdf2;181;174;176;175;178;173;171;170;172;173 04:58:05 INFO - PROCESS | 9075 | |13;stanford-crypto-sha256-iterative;74;73;72;78;74;73;78;71;71;69 04:58:05 INFO - PROCESS | 9075 | __end_tp_report 04:58:05 INFO - PROCESS | 9075 | __start_cc_report 04:58:05 INFO - PROCESS | 9075 | _x_x_mozilla_cycle_collect,920 04:58:05 INFO - PROCESS | 9075 | __end_cc_report 04:58:05 INFO - PROCESS | 9075 | __startTimestamp1461067085723__endTimestamp 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | ------- Summary: start ------- 04:58:05 INFO - PROCESS | 9075 | Number of tests: 14 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.22 (3.7%) stddev-sans-first:4.47 04:58:05 INFO - PROCESS | 9075 | Values: 113.0 107.0 112.0 113.0 113.0 124.0 112.0 112.0 114.0 113.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#1] audio-beat-detection Cycles:10 Average:157.90 Median:166.50 stddev:18.17 (10.9%) stddev-sans-first:19.21 04:58:05 INFO - PROCESS | 9075 | Values: 162.0 138.0 167.0 173.0 138.0 166.0 168.0 138.0 189.0 140.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.77 (2.3%) stddev-sans-first:3.81 04:58:05 INFO - PROCESS | 9075 | Values: 161.0 164.0 162.0 167.0 173.0 162.0 164.0 161.0 167.0 162.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#3] audio-fft Cycles:10 Average:91.20 Median:75.50 stddev:32.11 (42.5%) stddev-sans-first:33.58 04:58:05 INFO - PROCESS | 9075 | Values: 76.0 74.0 77.0 155.0 79.0 77.0 75.0 75.0 149.0 75.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:23.88 (25.4%) stddev-sans-first:24.70 04:58:05 INFO - PROCESS | 9075 | Values: 94.0 94.0 150.0 95.0 94.0 96.0 138.0 93.0 94.0 142.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:58:05 INFO - PROCESS | 9075 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 120.0 118.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 04:58:05 INFO - PROCESS | 9075 | Values: 147.0 148.0 150.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:58:05 INFO - PROCESS | 9075 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.00 stddev:5.89 (9.2%) stddev-sans-first:6.25 04:58:05 INFO - PROCESS | 9075 | Values: 65.0 64.0 64.0 63.0 64.0 64.0 63.0 82.0 63.0 62.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 04:58:05 INFO - PROCESS | 9075 | Values: 67.0 65.0 65.0 64.0 66.0 65.0 65.0 65.0 65.0 66.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.27 (4.0%) stddev-sans-first:2.52 04:58:05 INFO - PROCESS | 9075 | Values: 88.0 79.0 79.0 82.0 87.0 80.0 80.0 81.0 81.0 79.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:140.50 stddev:11.97 (8.5%) stddev-sans-first:12.32 04:58:05 INFO - PROCESS | 9075 | Values: 134.0 141.0 134.0 139.0 145.0 134.0 140.0 136.0 174.0 146.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.50 stddev:3.33 (1.9%) stddev-sans-first:2.51 04:58:05 INFO - PROCESS | 9075 | Values: 181.0 174.0 176.0 175.0 178.0 173.0 171.0 170.0 172.0 173.0 04:58:05 INFO - PROCESS | 9075 | 04:58:05 INFO - PROCESS | 9075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.50 stddev:2.91 (4.0%) stddev-sans-first:3.07 04:58:05 INFO - PROCESS | 9075 | Values: 74.0 73.0 72.0 78.0 74.0 73.0 78.0 71.0 71.0 69.0 04:58:05 INFO - PROCESS | 9075 | -------- Summary: end -------- 04:58:05 INFO - PROCESS | 9075 | 04:58:06 INFO - TEST-INFO | 9075: exit 0 04:58:06 INFO - TEST-OK | kraken | took 64235ms 04:58:06 INFO - SUITE-END | took 1179s 04:58:07 INFO - Completed test suite (00:19:40) 04:58:07 INFO - javascript benchmark 04:58:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.092618046774, 2688.623592697024, 2690.4350086481836, 2746.491898998684, 2752.0, 4718.693284936477, 4758.666893317469, 4787.305840653104, 4807.831725889595, 4831.033793241349, 4665.9766701166445, 4779.426468823737, 4793.041391721661, 4804.375431193948, 4823.155947709146, 4399.186150562156, 4445.199864024475, 4471.061077173781, 4486.820527178909, 4535.977320113411, 479.80298245409574, 4284.528701842794, 4346.84786032489, 4353.564643535637, 4362.607365337135, 4398.516163222043, 4409.559044095597, 4419.337099435078, 4429.15845989261, 4437.735698664424, 4384.934225986613, 4415.690901636886, 4416.447944006999, 4425.7565833879125, 4475.037866858608, 4340.8480703175555, 4396.054848207618, 4412.691111622188, 4432.84485043022, 4454.955450445519, 4695.577398034159, 4710.693804902705, 4718.197906355894, 4723.7874295656775, 4732.52674732524, 4910.680805747615, 5080.237964305346, 5166.560842328407, 5170.1986192140275, 5173.896522069575, 5150.381954165487, 5183.974080129613, 5201.661891977009, 5204.089284375257, 5252.789888404459, 4785.49752276013, 4823.131836269435, 4829.082474329901, 4849.078675051729, 4895.143349913751, 4948.282499037619, 5173.405058418255, 5223.059849227176, 5308.946910530923, 5400.054990376669, 4990.451050384455, 5011.373578302712, 5020.49795020495, 5033.748312584356, 5065.949340506621, 5104.157813960729, 5117.616178786606, 5119.539241468286, 5120.539151476385, 5166.509181627739, 4894.510548945148, 4987.750612469362, 5061.949380506221, 5062.417821950449, 5080.009398167395, 5102.311187989648, 5102.515261050195, 5103.0, 5123.462036486189, 5185.377754669464, 4318.805653745589, 4320.200762858818, 4324.545922678073, 4327.740335579812, 4381.693281470267, 3641.289948460025, 3683.042408973686, 3756.042209236627, 3818.1409182933617, 3886.591907849692, 4502.459704835375, 4514.571115744065, 4540.841070562515, 4541.137183935041, 4549.840755573539, 5136.4606716295, 5151.871203219949, 5156.303898973591, 5168.689878607295, 5208.322918020633, 4383.189110014658, 4442.755648439303, 4473.4408198975125, 4519.118771839526, 4519.163954668331, 4587.059652771174, 4587.907586432923, 4603.033362993809, 4618.168729628632, 4639.8936940807625, 4802.423709154924, 4813.422389313375, 4816.012717392996, 4816.157172494799, 4861.611071114373, 4985.451600323889, 5086.6439349246675, 5127.128388174094, 5156.587473002226, 5199.48005199477, 4818.927716084331, 4834.087255225062, 4848.0, 4863.756812159449, 4892.143874821821, 5056.82301119459, 5083.87290317745, 5092.930484598276, 5098.97450512745, 5148.510891465305, 5039.47085556026, 5076.416212135652, 5144.331236939174, 5161.019406312938, 5180.48195180479, 4965.702057876539, 4991.126552853309, 4993.725345106054, 5005.549500544968, 5034.4462109167225, 4976.900461990812, 4984.575822664402, 4996.2505624156665, 5000.924986125138, 5007.39911210657, 4879.804807807648, 4880.658353915192, 4891.682040667345, 4906.533879281463, 4949.985253023049, 5028.84913452597, 5034.899302014012, 5037.848864534069, 5048.192289233705, 5095.082885080573, 4764.094821983812, 4819.1566475867285, 4943.036107958914, 4947.356843610308, 4983.501649834988], "value": 4679.136512887946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.3169525807175, 601.0083362451953, 618.5762752514528, 620.7672122953892, 657.3919124809549, 33252.16869578259, 33888.830555847184, 34177.658223417755, 34310.0, 34329.82835085824, 34635.82682086592, 34947.0, 35182.12044698884, 35276.2944741105, 35282.647173528254, 7574.84850302995, 7722.420818438612, 7726.575038372887, 7727.884081738778, 7739.2260773922435, 7578.242175782405, 7827.0, 7836.2947334739865, 7842.176571460001, 7851.921480785205, 7814.296713295802, 7815.882761758578, 7824.804379890491, 7890.56601886896, 7894.881576776353, 7808.570528620923, 7856.25365590268, 7864.056313242419, 7874.173211812792, 7882.566458844762, 7747.612619369065, 7812.921870781276, 7845.176256493043, 7849.8037549061155, 7858.921410785933, 28600.0, 34167.145821354665, 34703.30593388118, 34708.0, 34850.0, 2933.779966502521, 2968.1095671298526, 2996.310848504834, 3122.5784519090084, 3518.5074089627474, 24011.39971500709, 24855.751442485525, 28224.15327540177, 28946.565801512996, 29001.274968125756, 3333.949990750141, 3364.142143753352, 3370.359631669975, 3452.7755695879687, 3462.272922686239, 203166.0, 206179.0, 206262.0, 206972.0, 208354.9999999985, 52211.47788522142, 52690.0, 53023.0, 53049.469505304456, 53094.0, 49299.0, 61520.38479615146, 63194.68402658049, 63897.0, 63962.0, 13507.662308442368, 13674.794878076837, 13701.588952331445, 13725.176489410667, 13798.586042418743, 10217.846732299022, 10232.64185753495, 10283.125934295518, 10291.073803357735, 10293.125084367912, 17919.46241612754, 18008.459746207634, 18163.54591135206, 18183.45449636513, 18236.54408639768, 6718.865622687519, 6950.54821436605, 6989.93010069903, 7076.610786406694, 7133.785986420416, 898.1018981018981, 933.4725879877848, 965.0590674092704, 976.472704739447, 1047.6228557719214, 25819.612705809428, 25922.74077259241, 25952.74047259541, 26253.34366640849, 26299.605505917043, 961.0725649748026, 986.5659109991581, 992.9702108936743, 1026.7689769801884, 1113.7494063835572, 13726.519571815139, 14128.152310861176, 14331.0, 14364.712705745827, 14548.054376465707, 325857.0, 333293.0, 333395.0, 333782.0, 334280.0, 49011.0, 49499.0, 49930.750346248766, 49939.0, 49942.50057499451, 1195.1335281920713, 1223.1682455929874, 1230.2618428942742, 1245.2715161630367, 1251.8560365557896, 25443.87278063598, 26683.0, 26782.59826102649, 27004.0, 27024.32439189036, 40311.39532907067, 46465.30302045404, 47486.050278993534, 47902.760486197345, 48247.51752482571, 309092.0, 310937.0, 311615.0, 313524.0, 314958.0, 37535.62464375321, 37735.433968491045, 37969.0, 38125.428118577685, 38580.614193857706, 41567.14708313866, 42057.369139463546, 42174.0, 42235.7888210557, 42575.574244257165, 35041.474377884864, 35175.296494070484, 35568.28863422665, 35967.820160900075, 36182.0, 34594.65405346015, 35222.647773522964, 35462.0, 35640.0, 35727.28545429129, 35332.99060149421, 35922.64077359193, 36395.63604363923, 36576.0, 36794.816025919696, 31178.376432471676, 32257.774222578493, 32861.50707739434, 32959.67040329662, 32982.175445614055, 25531.617025745, 25562.23313300604, 25638.82070024069, 25801.741982579933, 25992.610110847974], "value": 17341.270631084968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.7122158381215, 384.78452066842567, 386.6848518457457, 397.05698964958225, 397.4118304908737, 15168.924155379222, 16246.350145994162, 16402.17989100543, 16446.42437514687, 16461.670766584662, 15504.612384690388, 16047.0, 16489.752653710202, 16628.33486660535, 16639.50081497557, 4972.527609877065, 5097.923531147036, 5098.541131298182, 5138.7173705446185, 5144.228365745131, 4748.477667456577, 5033.823816166435, 5104.285400043978, 5149.74251287436, 5153.330067091273, 4990.625703072266, 5020.246962955568, 5025.547700706936, 5042.117629414856, 5063.265826455162, 4904.411470623512, 5880.9411905880825, 5883.382244864292, 5889.911651325234, 5897.8230653080045, 5055.974720126413, 5173.689578625294, 5182.481751824825, 5196.68819870809, 5221.947780522184, 11738.94130529342, 11810.0, 11973.521059157623, 11978.341191234478, 12002.339871307075, 1787.8289720233267, 1837.2926423326983, 2046.1815273890413, 2148.130007347027, 2228.075348730275, 9526.0, 9533.0, 11236.988671019648, 12254.08094392924, 12260.509579616804, 1649.7772800671876, 1678.2783403136646, 1702.1489255372314, 1732.3936622182262, 1779.359430604981, 64262.357376426575, 66363.0, 67380.6630966842, 68141.3185868145, 68227.0, 9895.208383329316, 10171.186305095574, 10178.11704834608, 10245.231607629308, 10326.793464130675, 13854.792178117335, 13925.930370348084, 13927.373268202955, 13986.16083035021, 14025.438982440588, 6809.285025072395, 7066.929330706627, 7082.433405327562, 7204.855902881913, 7211.927880721126, 6395.0, 6401.263854656774, 6495.3179916109075, 6573.605583664996, 6661.067450556926, 4257.616814486649, 4287.228298906164, 4315.266404711207, 4328.891777705582, 4421.579949904753, 1813.1296977450897, 1835.431016384925, 1841.9631607367778, 1842.990785046093, 1873.278787666758, 920.3281604428804, 927.1053433436631, 935.3966691483955, 971.7522031881825, 974.7173319737338, 16081.839181608268, 16593.91703041477, 16960.74558881618, 17197.484075477754, 17201.967881927125, 852.497026754218, 915.4324318922311, 920.7329874336501, 926.2034650200821, 978.7259567321162, 7799.3760499159935, 9474.952625236967, 9502.097300756417, 9602.711918642452, 9712.17446517054, 363778.0, 369694.0, 372260.0, 379816.0, 381288.0, 56025.43974560202, 75144.0, 77193.83940587084, 77420.61289693516, 79858.0, 820.6881385073754, 842.2588122452325, 845.1252953193415, 845.8477474054606, 847.2501835875295, 13916.165030098227, 14265.857341426452, 14361.497347592784, 14433.566992990227, 14546.345414456586, 32375.190620234684, 33598.66401335955, 33739.83130084334, 33775.3244935095, 34465.48301775425, 46270.53729462797, 46377.53622463732, 46415.303770444145, 46494.53505464902, 46896.53103469058, 6231.096491008869, 6591.011348297794, 7741.922580774345, 7892.4869883457395, 7979.760607181794, 10540.789184216426, 11405.0, 11649.941750291195, 11843.0, 12025.819612705642, 10094.091531762177, 10299.742506437398, 10438.791224175626, 10508.106810921157, 10560.049595536131, 10210.438425886647, 10296.433696146783, 10388.48057597102, 10503.632372866912, 10507.73730656709, 10200.693979180636, 10221.33561318512, 10505.31715438494, 10613.787724245627, 10698.839517407401, 6825.863482730417, 6838.247792742894, 6897.379235868796, 6897.517173797986, 7051.189113252041, 7860.960695196487, 10179.796404072025, 10459.372437653765, 10610.946945265534, 10755.677329680122], "value": 7960.792795714637, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.8419473857873, 1486.925653717314, 1631.8449747274012, 1760.137532609022, 1810.3663717698814, 6696.062551242818, 7597.164311925684, 7660.119086305077, 7896.170902055281, 7914.129445760962, 7632.542047477142, 7653.31120199182, 7681.039870016248, 7718.691252349913, 7721.420893433001, 2195.7804219577993, 2225.7440394354694, 2235.7428895676962, 2238.608243557379, 2242.7981481666648, 2188.2231807708195, 2211.8009379155874, 2259.1302348595827, 2261.4685548895995, 2261.5250797332496, 2233.1737257214854, 2263.25312646827, 2263.581237471073, 2265.728112626487, 2285.874276914769, 2221.4113259986116, 2225.4436390902274, 2229.7101376820992, 2234.888255587214, 2242.383344580237, 2196.560687862434, 2205.5368372641765, 2206.4042708468623, 2216.2021672198, 2223.032980653421, 7777.494462859896, 7881.842363152705, 7905.920940790634, 7922.881156782653, 7931.286184243388, 4658.534146585314, 4818.542238487338, 4821.5178482151505, 4826.107170173494, 4833.32333473314, 2812.7187281271913, 2970.450466663674, 2975.925601859949, 2980.3890202508433, 3008.368242669042, 929.6327950459531, 934.243262957007, 954.3939598355025, 958.2525630008604, 965.2181732796387, 10480.0, 10577.524011419428, 10585.788284234271, 10610.575576976911, 10664.253502254924, 4225.619694227535, 4251.9787401062795, 4400.0, 4432.977835110803, 4468.486124095771, 9049.77375565603, 9071.228945539571, 9092.772680683036, 9104.954475227714, 9112.772180695536, 4780.235162374003, 4796.664233503691, 4821.5178482151505, 4829.879253018632, 4842.297866809364, 3758.285925674113, 4243.0, 4385.890352741207, 4385.956140438555, 4400.845970391021, 3792.222594368148, 3807.1053302473897, 3888.8055597220027, 3897.2205558888336, 3940.5074365704286, 1251.474380760083, 1260.212367270456, 1270.491803278696, 1276.5787290194214, 1277.3613193403298, 832.800127969283, 835.3526017336612, 837.2632083766247, 851.9233269005696, 857.5540718826176, 5127.384713834289, 5187.377514698261, 5252.343457067866, 5403.7838486460105, 5458.808941687022, 422.04752492903737, 422.8646833013406, 424.8576726796496, 425.9637930775857, 429.4052736959334, 3589.7794749784675, 3651.9817400912825, 3681.4109742441615, 3726.7763934163495, 3759.9248015039548, 9442.952785236168, 9765.462899540593, 9894.950525247472, 9918.900810991941, 9957.203423726085, 9144.81710365789, 9586.328956973084, 9666.323357365058, 9715.174210192214, 9747.658831940847, 6862.862742745117, 6884.173899132136, 6911.377975982085, 6992.230854605989, 7037.261087585832, 5171.224316352577, 5312.9734351328, 5389.703566303734, 5460.31746031746, 5505.807296744595, 8828.475753441648, 8928.375013748975, 8937.419067760575, 8968.23769979559, 8996.325275604226, 9005.459672419676, 9319.767005824637, 9332.72001839946, 9367.718968430958, 9386.202172815114, 6141.109539116714, 6435.742570297136, 6639.402453779183, 6899.17209934811, 6993.965030174817, 7116.46626503004, 7151.713931442684, 7202.639868006474, 7209.6034718091005, 7219.530730502501, 6340.619562826245, 6343.116248941079, 6437.839054023687, 6616.437602803816, 6660.367265109807, 6401.167848179707, 6426.29310775805, 6542.738290468518, 6576.901346479903, 6716.630585317855, 6093.421124993119, 6210.378962103753, 6211.316755156839, 6223.190985171898, 6250.0937364082865, 4488.618467430305, 4567.771611419482, 4570.794314255933, 4601.723896566216, 4677.742724150068, 4481.663875209307, 4578.931316030195, 4626.213543697512, 4635.0498147878925, 4667.929981050355], "value": 4108.069404586982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4193704552147, 319.44576160361765, 323.7636525336504, 327.3355089168988, 330.0214862931408, 5371.543418809401, 5378.408375078739, 5393.191021346795, 5420.783168673248, 5474.178873169017, 5362.24928510008, 5367.302250707412, 5369.463053694629, 5376.623636345457, 5377.327834020747, 3918.4318273850204, 4060.533038700558, 4185.0, 4195.685323600727, 4198.622124008839, 4169.332906734923, 4187.1416359646355, 4193.2242535130945, 4200.0, 4203.180379825935, 4115.012397024708, 4128.442660240874, 4146.523149837762, 4154.792260386968, 4155.8753237402925, 4045.9797701011603, 4130.277201489742, 4152.750834949913, 4185.434966279544, 4201.34879093741, 3663.9267214655556, 3671.467637192619, 3673.1918977824835, 3676.6507181817683, 3678.3746763050076, 5166.07010738067, 5182.352205974254, 5184.345036749083, 5187.584993200535, 5193.584513238932, 4737.289406589005, 4819.951800481986, 4821.132196204681, 4834.58905992991, 4873.390826146731, 5635.5773317001385, 5651.1523271509195, 5675.233843431167, 5695.231143795576, 5699.888521738263, 4023.919521609581, 4037.3338399164104, 4039.4546736190828, 4050.4936882889638, 4050.7569545827346, 5763.682997435139, 5920.911186332209, 5947.910781338283, 6006.909896351558, 6009.248843894513, 4080.81636326366, 4092.5907409258834, 4100.958990410118, 4112.177564487115, 4121.835126594962, 4168.541460439349, 4170.645495132948, 4173.353130264813, 4178.26880295947, 4181.832726690898, 4641.698289611165, 4758.143534163814, 4766.809327626926, 4773.37946067009, 4775.856724298276, 5623.803166889221, 5629.887402251932, 5632.718364081779, 5640.802571909963, 5642.4075472075665, 1442.3941944383384, 1451.2888684544498, 1456.83974762776, 1466.142306750563, 1473.359088796377, 890.6392910871108, 978.5498670611598, 981.474910922653, 1001.6594357918343, 1025.410389026313, 4895.412550493892, 4919.483454237254, 4935.975320123376, 4958.132326842788, 4964.8758781030765, 5790.449907258803, 5800.8259752207505, 5811.186433899257, 5813.563982701315, 5824.650520968756, 4798.136335459651, 4917.336159618406, 4928.531789479994, 4930.235813448921, 4937.580305673986, 3093.0875391759487, 3102.100390886663, 3119.594452721132, 3120.0795765249304, 3123.7504998000527, 5376.220448035013, 5396.109641909041, 5403.2165336026055, 5414.539764120015, 5470.316210473691, 5750.971245143747, 5944.167816505693, 5967.671778052249, 5987.161797348374, 5987.341392446828, 5330.866728331823, 5363.785448582013, 5396.91904621431, 5405.0, 5424.0, 5638.802641907678, 5750.137479378127, 5794.681292528951, 5805.738741756547, 5821.825345239649, 5645.887082258249, 5652.717364131695, 5712.914306285326, 5732.598718089694, 5734.885302294014, 5395.217693434509, 5439.836804895859, 5441.619086663895, 5459.39946605881, 5461.371942226695, 3808.562015368268, 4079.7960101994186, 4095.4675892133832, 4123.257813593582, 4136.896577585464, 5891.793787217427, 5892.292924849045, 5896.056630939029, 5896.321922978741, 5901.0, 5650.3219613646625, 5661.547076233809, 5685.061964775766, 5698.430156984268, 5705.343885453226, 5488.588355873405, 5680.204771331934, 5688.829335119953, 5700.287464066992, 5713.857153571028, 5315.893682126413, 5581.609287349846, 5600.3356006352315, 5601.80393686219, 5612.803551875665, 5490.258815059916, 5644.887102258014, 5658.858528536654, 5702.34423041339, 5719.971400142973, 5546.278983732089, 5585.3297604287745, 5588.105903055492, 5605.51453864718, 5632.746526406403], "value": 4246.960107163928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.2959315160174, 665.5574043261231, 691.5939000422916, 692.6675195905965, 693.7259782385958, 11623.418829058544, 11678.824817627732, 11711.824322635157, 11765.176437649368, 11876.28742275464, 11094.112471002321, 11505.769884602303, 11708.063354931606, 11708.648740537797, 11723.0621550276, 640.0431355124095, 780.6487080813628, 807.1283014344508, 811.9512829230235, 817.382875928676, 813.5240884082789, 813.556611646654, 815.3925325632412, 816.4488969945293, 818.071488860145, 850.5917159763318, 855.9957200214021, 857.7040920882285, 858.7853036740814, 862.8144948835999, 844.8225872566768, 846.289117141604, 846.894138232724, 847.1401527449643, 853.5092321914892, 627.0218459203656, 627.0468887291337, 627.9529035322369, 630.0297541785644, 632.1971096707202, 12197.756044879141, 12224.266544007389, 12230.388480575935, 12237.449314780857, 12255.571055013032, 12370.381480925918, 12538.623841284776, 12563.56027539041, 12624.431900564497, 12878.935605322007, 11037.889621103766, 11050.723731906766, 11172.776544469147, 11310.604128855533, 11371.488283027202, 4225.281702110648, 4237.194932962727, 4253.659707223414, 4286.57134286572, 4427.291633338683, 44429.77785111086, 44695.0, 44882.77558612219, 44888.551114488764, 45036.3244551332, 9300.8604870927, 9340.0, 9418.434893906388, 9423.858642120374, 9454.48000359973, 16741.330346786235, 16876.83123168777, 16926.32294708198, 16977.49067527976, 17697.911510442365, 6309.779157729457, 6374.936250637527, 6483.902741458882, 6511.316311787289, 6547.705353259114, 3400.8777103555767, 3403.030136411111, 3414.914627134292, 3424.8972530824117, 3478.8300103631236, 2800.551911694119, 2843.090211132459, 2876.964292854571, 2880.15035564509, 2891.79757416983, 508.12907075025663, 520.3079903728033, 523.1472699499791, 526.6655673647261, 530.4880790037555, 556.8858384031264, 581.2879222951934, 585.4496773033335, 586.8855573163193, 596.6360520082746, 7642.96178519115, 7678.424118191158, 7766.534007959427, 7839.216078392115, 7946.404019698546, 494.2141994229193, 586.8268860686107, 587.8060240120835, 590.9451628842495, 598.6228675934134, 3643.872464463731, 3775.5091838060875, 3809.561900381492, 3944.881653550398, 4224.831006759757, 44655.33017004748, 45206.547934520895, 45984.0, 46303.5369646306, 47970.5202947966, 39537.40693889594, 40039.19921601551, 40498.39252411216, 40667.0, 40978.79510602428, 37919.81040094837, 39988.60011399907, 40031.0, 40655.1868962625, 40692.0, 8046.396520261121, 8145.592720364077, 8158.673653053811, 8198.344132469269, 8377.162283771575, 28304.716952831033, 28352.432951340445, 28550.0, 28570.857145714137, 28718.138455846358, 36111.0, 37927.0, 37965.0, 38289.0, 38365.232695346494, 10552.947235263775, 10574.524146413276, 10680.57277708883, 10827.621033263798, 10848.837267441153, 11645.47595358194, 11803.645890623295, 11832.408379580815, 11919.940400297943, 12123.818142728043, 11084.778304433705, 11108.833367499332, 11181.496832642713, 11276.774464510829, 11284.266522676, 10214.795704086026, 10402.739931501774, 10532.736681583021, 10748.83876741865, 10766.676999690022, 10440.37357758537, 11123.443827808738, 11331.32012079278, 11337.943310283395, 11348.886511134782, 8739.737807865775, 9351.205147562534, 9567.569459374206, 9971.950140249251, 10000.2999790014, 8905.376623636283, 9014.2788576915, 9027.4132181408, 9574.0, 9593.136617704162], "value": 5860.309712311326, "unit": "score"}], "name": "dromaeo_css", "value": 6357.904772813161, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 113.0, 113.0, 124.0, 112.0, 112.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 138.0, 167.0, 173.0, 138.0, 166.0, 168.0, 138.0, 189.0, 140.0], "value": 157.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 167.0, 173.0, 162.0, 164.0, 161.0, 167.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 155.0, 79.0, 77.0, 75.0, 75.0, 149.0, 75.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 150.0, 95.0, 94.0, 96.0, 138.0, 93.0, 94.0, 142.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 120.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 150.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 82.0, 63.0, 62.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 79.0, 82.0, 87.0, 80.0, 80.0, 81.0, 81.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 134.0, 139.0, 145.0, 134.0, 140.0, 136.0, 174.0, 146.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 174.0, 176.0, 175.0, 178.0, 173.0, 171.0, 170.0, 172.0, 173.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 78.0, 74.0, 73.0, 78.0, 71.0, 71.0, 69.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1598.3999999999999, "alertThreshold": 2.0}]} 04:58:07 INFO - Return code: 0 04:58:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:07 ERROR - # TBPL SUCCESS # 04:58:07 INFO - Running post-action listener: _resource_record_post_action 04:58:07 INFO - Running post-run listener: _resource_record_post_run 04:58:08 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520093696; Read time: 24; Write time: 699952 04:58:08 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234217472; Read time: 0; Write time: 425812 04:58:08 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285876224; Read time: 24; Write time: 274140 04:58:08 INFO - Running post-run listener: _upload_blobber_files 04:58:08 INFO - Blob upload gear active. 04:58:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:08 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 04:58:08 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'] 04:58:08 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 04:58:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:58:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:09 INFO - (blobuploader) - INFO - Done attempting. 04:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:10 INFO - (blobuploader) - INFO - Done attempting. 04:58:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:10 INFO - Return code: 0 04:58:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5bdb585a56df8f0ad8314cba8df53e1cb2127ce593a93d2d37ed0e1ca1ddaa3053d49b8327766a6e443b30b03dd295d4b49fff7fdbd48ac6e4e28718a4330185", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a773be43361793e2fc5cd1d5449e281b279ef78cc2a5d951c1e8b7037e4ecb49c6f304a0d66e6d07648ed6daff0b14ceda70fa10dcfe34ef45f47fc2a7e73f9"} 04:58:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:10 INFO - Contents: 04:58:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5bdb585a56df8f0ad8314cba8df53e1cb2127ce593a93d2d37ed0e1ca1ddaa3053d49b8327766a6e443b30b03dd295d4b49fff7fdbd48ac6e4e28718a4330185", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a773be43361793e2fc5cd1d5449e281b279ef78cc2a5d951c1e8b7037e4ecb49c6f304a0d66e6d07648ed6daff0b14ceda70fa10dcfe34ef45f47fc2a7e73f9"} 04:58:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:10 INFO - Copying logs to upload dir... 04:58:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.274941 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-19 04:58:10.718422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:10.722525) ========= 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-1461065319.464287-514348873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5bdb585a56df8f0ad8314cba8df53e1cb2127ce593a93d2d37ed0e1ca1ddaa3053d49b8327766a6e443b30b03dd295d4b49fff7fdbd48ac6e4e28718a4330185", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a773be43361793e2fc5cd1d5449e281b279ef78cc2a5d951c1e8b7037e4ecb49c6f304a0d66e6d07648ed6daff0b14ceda70fa10dcfe34ef45f47fc2a7e73f9"} build_url:https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5bdb585a56df8f0ad8314cba8df53e1cb2127ce593a93d2d37ed0e1ca1ddaa3053d49b8327766a6e443b30b03dd295d4b49fff7fdbd48ac6e4e28718a4330185", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a773be43361793e2fc5cd1d5449e281b279ef78cc2a5d951c1e8b7037e4ecb49c6f304a0d66e6d07648ed6daff0b14ceda70fa10dcfe34ef45f47fc2a7e73f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:10.747583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:10.747929) ========= 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-1461065319.464287-514348873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:10.830154) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:58:10.830479) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:58:10.830800) ========= ========= Total master_lag: 0.18 =========