builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1457026374.38 results: success (0) buildid: 20160301053641 builduid: 4ed4d0b337e24c078facd395c588a4a4 revision: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.380188) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.380658) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.380947) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006253 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.403977) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.404296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.417506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.417877) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.467120) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.467431) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.467773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.468042) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 09:32:55-- 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% 89.2M=0s 2016-03-03 09:32:56 (89.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.470274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.950438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:54.950765) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020167 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.000242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.000608) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4929411c0aa3ec6b727e2bc2fc050c8199c6573 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a4929411c0aa3ec6b727e2bc2fc050c8199c6573 --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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 09:32:56,192 truncating revision to first 12 chars 2016-03-03 09:32:56,192 Setting DEBUG logging. 2016-03-03 09:32:56,192 attempt 1/10 2016-03-03 09:32:56,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4929411c0aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 09:32:56,803 unpacking tar archive at: mozilla-central-a4929411c0aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919723 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.933950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.934347) ========= echo a4929411c0aa3ec6b727e2bc2fc050c8199c6573 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4929411c0aa3ec6b727e2bc2fc050c8199c6573'] 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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a4929411c0aa3ec6b727e2bc2fc050c8199c6573 program finished with exit code 0 elapsedTime=0.003843 script_repo_revision: 'a4929411c0aa3ec6b727e2bc2fc050c8199c6573' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.983219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.983545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 09:32:55.993533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-03 09:32:55.993960) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:57 INFO - MultiFileLogger online at 20160303 09:32:57 in /builds/slave/test 09:32:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:32:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:57 INFO - {'append_to_log': False, 09:32:57 INFO - 'base_work_dir': '/builds/slave/test', 09:32:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:32:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:57 INFO - 'branch': 'Firefox-Non-PGO', 09:32:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:57 INFO - 'config_files': ('talos/linux_config.py',), 09:32:57 INFO - 'default_actions': ('clobber', 09:32:57 INFO - 'read-buildbot-config', 09:32:57 INFO - 'download-and-extract', 09:32:57 INFO - 'populate-webroot', 09:32:57 INFO - 'create-virtualenv', 09:32:57 INFO - 'install', 09:32:57 INFO - 'run-tests'), 09:32:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:57 INFO - 'download_minidump_stackwalk': True, 09:32:57 INFO - 'download_symbols': 'ondemand', 09:32:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:57 INFO - 'installer_path': 'installer.exe', 09:32:57 INFO - 'log_level': 'info', 09:32:57 INFO - 'log_name': 'talos', 09:32:57 INFO - 'log_to_console': True, 09:32:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:57 INFO - 'opt_config_files': (), 09:32:57 INFO - 'pip_index': False, 09:32:57 INFO - 'sps_profile': False, 09:32:57 INFO - 'sps_profile_interval': 0, 09:32:57 INFO - 'suite': 'dromaeojs-e10s', 09:32:57 INFO - 'system_bits': '32', 09:32:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:57 INFO - 'title': 'talos-linux64-ix-061', 09:32:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:57 INFO - 'use_talos_json': True, 09:32:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:57 INFO - 'work_dir': 'build'} 09:32:57 INFO - ##### 09:32:57 INFO - ##### Running clobber step. 09:32:57 INFO - ##### 09:32:57 INFO - Running pre-action listener: _resource_record_pre_action 09:32:57 INFO - Running main action method: clobber 09:32:57 INFO - rmtree: /builds/slave/test/build 09:32:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:58 INFO - Running post-action listener: _resource_record_post_action 09:32:58 INFO - ##### 09:32:58 INFO - ##### Running read-buildbot-config step. 09:32:58 INFO - ##### 09:32:58 INFO - Running pre-action listener: _resource_record_pre_action 09:32:58 INFO - Running main action method: read_buildbot_config 09:32:58 INFO - Using buildbot properties: 09:32:58 INFO - { 09:32:58 INFO - "project": "", 09:32:58 INFO - "product": "firefox", 09:32:58 INFO - "script_repo_revision": "production", 09:32:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:32:58 INFO - "repository": "", 09:32:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:32:58 INFO - "buildid": "20160301053641", 09:32:58 INFO - "pgo_build": "False", 09:32:58 INFO - "basedir": "/builds/slave/test", 09:32:58 INFO - "buildnumber": 233, 09:32:58 INFO - "slavename": "talos-linux64-ix-061", 09:32:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:32:58 INFO - "platform": "ubuntu64_hw", 09:32:58 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:32:58 INFO - "branch": "mozilla-central", 09:32:58 INFO - "repo_path": "mozilla-central", 09:32:58 INFO - "revision": "a4929411c0aa3ec6b727e2bc2fc050c8199c6573", 09:32:58 INFO - "stage_platform": "linux64", 09:32:58 INFO - "builduid": "4ed4d0b337e24c078facd395c588a4a4", 09:32:58 INFO - "slavebuilddir": "test" 09:32:58 INFO - } 09:32:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:32:58 INFO - Running post-action listener: _resource_record_post_action 09:32:58 INFO - ##### 09:32:58 INFO - ##### Running download-and-extract step. 09:32:58 INFO - ##### 09:32:58 INFO - Running pre-action listener: _resource_record_pre_action 09:32:58 INFO - Running main action method: download_and_extract 09:32:58 INFO - mkdir: /builds/slave/test/build/tests 09:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:58 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:32:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:32:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:32:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:32:58 INFO - Downloaded 1448 bytes. 09:32:58 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:32:58 INFO - Using the following test package requirements: 09:32:58 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:32:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:32:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'jsshell-linux-x86_64.zip'], 09:32:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:32:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:32:58 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:32:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:32:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:32:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:32:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:32:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:58 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:32:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:32:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:32:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:59 INFO - Downloaded 22077766 bytes. 09:32:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:32:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:01 INFO - Return code: 0 09:33:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:01 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:02 INFO - Downloaded 22077766 bytes. 09:33:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:03 INFO - Return code: 0 09:33: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')]} 09:33:03 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:04 INFO - Downloaded 10713413 bytes. 09:33:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:33:05 INFO - Return code: 0 09:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:05 INFO - https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:33:06 INFO - Downloaded 54835652 bytes. 09:33:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:33:06 INFO - mkdir: /builds/slave/test/properties 09:33:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:06 INFO - Contents: 09:33:06 INFO - build_url:https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:33:07 INFO - Running post-action listener: _resource_record_post_action 09:33:07 INFO - Running post-action listener: set_extra_try_arguments 09:33:07 INFO - ##### 09:33:07 INFO - ##### Running populate-webroot step. 09:33:07 INFO - ##### 09:33:07 INFO - Running pre-action listener: _resource_record_pre_action 09:33:07 INFO - Running main action method: populate_webroot 09:33:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:07 INFO - '--tppagecycles', 09:33:07 INFO - '7'], 09:33:07 INFO - 'tests': ['tsvgm']}}, 09:33:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:33:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:33:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'tests': ['damp', 'tps']}, 09:33:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['damp', 'tps']}, 09:33:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:33:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:07 INFO - 'other': {'tests': ['a11yr', 09:33:07 INFO - 'ts_paint', 09:33:07 INFO - 'tpaint', 09:33:07 INFO - 'sessionrestore', 09:33:07 INFO - 'sessionrestore_no_auto_restore']}, 09:33:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['a11yr', 09:33:07 INFO - 'ts_paint', 09:33:07 INFO - 'tpaint', 09:33:07 INFO - 'sessionrestore', 09:33:07 INFO - 'sessionrestore_no_auto_restore']}, 09:33:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['a11yr', 09:33:07 INFO - 'ts_paint', 09:33:07 INFO - 'tpaint', 09:33:07 INFO - 'sessionrestore', 09:33:07 INFO - 'sessionrestore_no_auto_restore']}, 09:33:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['a11yr', 09:33:07 INFO - 'ts_paint', 09:33:07 INFO - 'tpaint', 09:33:07 INFO - 'sessionrestore', 09:33:07 INFO - 'sessionrestore_no_auto_restore']}, 09:33:07 INFO - 'other_l64': {'tests': ['a11yr', 09:33:07 INFO - 'ts_paint', 09:33:07 INFO - 'tpaint', 09:33:07 INFO - 'sessionrestore', 09:33:07 INFO - 'sessionrestore_no_auto_restore']}, 09:33:07 INFO - 'other_nol64': {'tests': ['a11yr', 09:33:07 INFO - 'ts_paint', 09:33:07 INFO - 'tpaint', 09:33:07 INFO - 'sessionrestore', 09:33:07 INFO - 'sessionrestore_no_auto_restore']}, 09:33:07 INFO - 'svgr': {'tests': ['tsvgx', 09:33:07 INFO - 'tsvgr_opacity', 09:33:07 INFO - 'tart', 09:33:07 INFO - 'tscrollx', 09:33:07 INFO - 'cart']}, 09:33:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['tsvgx', 09:33:07 INFO - 'tsvgr_opacity', 09:33:07 INFO - 'tart', 09:33:07 INFO - 'tscrollx', 09:33:07 INFO - 'cart']}, 09:33:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'tests': ['tp5o']}, 09:33:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'talos_options': ['--e10s'], 09:33:07 INFO - 'tests': ['tp5o']}, 09:33:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'talos_options': ['--xperf_path', 09:33:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:07 INFO - 'tests': ['tp5n']}, 09:33:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:07 INFO - 'talos_options': ['--e10s', 09:33:07 INFO - '--xperf_path', 09:33:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:07 INFO - 'tests': ['tp5n']}}, 09:33:07 INFO - 'talos.zip': {'path': '', 09:33:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:07 INFO - Running post-action listener: _resource_record_post_action 09:33:07 INFO - ##### 09:33:07 INFO - ##### Running create-virtualenv step. 09:33:07 INFO - ##### 09:33:07 INFO - Running pre-action listener: _resource_record_pre_action 09:33:07 INFO - Running main action method: create_virtualenv 09:33:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:07 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 09:33:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:07 INFO - Using real prefix '/usr' 09:33:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:10 INFO - Installing pip.................done. 09:33:10 INFO - Return code: 0 09:33:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:10 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')]} 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:10 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')]} 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:10 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:10 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 09:33:10 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 09:33:10 INFO - Using env: {'DISPLAY': ':0', 09:33:10 INFO - 'HOME': '/home/cltbld', 09:33:10 INFO - 'LANG': 'en_US.UTF-8', 09:33:10 INFO - 'LANGUAGE': 'en_US:en', 09:33:10 INFO - 'LOGNAME': 'cltbld', 09:33:10 INFO - 'MAIL': '/var/mail/cltbld', 09:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:10 INFO - 'MOZ_NO_REMOTE': '1', 09:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:10 INFO - 'NO_EM_RESTART': '1', 09:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:10 INFO - 'PWD': '/builds/slave/test', 09:33:10 INFO - 'SHELL': '/bin/bash', 09:33:10 INFO - 'SHLVL': '1', 09:33:10 INFO - 'TERM': 'linux', 09:33:10 INFO - 'TMOUT': '86400', 09:33:10 INFO - 'USER': 'cltbld', 09:33:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:10 INFO - '_': '/tools/buildbot/bin/python'} 09:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:10 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 09:33:10 INFO - Cleaning up... 09:33:10 INFO - Return code: 0 09:33:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:33:10 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')]} 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:10 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')]} 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:10 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:10 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 09:33:10 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 09:33:10 INFO - Using env: {'DISPLAY': ':0', 09:33:10 INFO - 'HOME': '/home/cltbld', 09:33:10 INFO - 'LANG': 'en_US.UTF-8', 09:33:10 INFO - 'LANGUAGE': 'en_US:en', 09:33:10 INFO - 'LOGNAME': 'cltbld', 09:33:10 INFO - 'MAIL': '/var/mail/cltbld', 09:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:10 INFO - 'MOZ_NO_REMOTE': '1', 09:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:10 INFO - 'NO_EM_RESTART': '1', 09:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:10 INFO - 'PWD': '/builds/slave/test', 09:33:10 INFO - 'SHELL': '/bin/bash', 09:33:10 INFO - 'SHLVL': '1', 09:33:10 INFO - 'TERM': 'linux', 09:33:10 INFO - 'TMOUT': '86400', 09:33:10 INFO - 'USER': 'cltbld', 09:33:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:10 INFO - '_': '/tools/buildbot/bin/python'} 09:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:10 INFO - Downloading/unpacking psutil>=0.7.1 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:12 INFO - Installing collected packages: psutil 09:33:12 INFO - Running setup.py install for psutil 09:33:12 INFO - building 'psutil._psutil_linux' extension 09:33:12 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 09:33:12 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 09:33:12 INFO - building 'psutil._psutil_posix' extension 09:33:12 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 09:33:13 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 09:33:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:13 INFO - Successfully installed psutil 09:33:13 INFO - Cleaning up... 09:33:13 INFO - Return code: 0 09:33:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:33:13 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')]} 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:13 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')]} 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:13 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:13 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 09:33:13 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 09:33:13 INFO - Using env: {'DISPLAY': ':0', 09:33:13 INFO - 'HOME': '/home/cltbld', 09:33:13 INFO - 'LANG': 'en_US.UTF-8', 09:33:13 INFO - 'LANGUAGE': 'en_US:en', 09:33:13 INFO - 'LOGNAME': 'cltbld', 09:33:13 INFO - 'MAIL': '/var/mail/cltbld', 09:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:13 INFO - 'MOZ_NO_REMOTE': '1', 09:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:13 INFO - 'NO_EM_RESTART': '1', 09:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:13 INFO - 'PWD': '/builds/slave/test', 09:33:13 INFO - 'SHELL': '/bin/bash', 09:33:13 INFO - 'SHLVL': '1', 09:33:13 INFO - 'TERM': 'linux', 09:33:13 INFO - 'TMOUT': '86400', 09:33:13 INFO - 'USER': 'cltbld', 09:33:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:13 INFO - '_': '/tools/buildbot/bin/python'} 09:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:33:15 INFO - Installing collected packages: mozsystemmonitor 09:33:15 INFO - Running setup.py install for mozsystemmonitor 09:33:15 INFO - Successfully installed mozsystemmonitor 09:33:15 INFO - Cleaning up... 09:33:15 INFO - Return code: 0 09:33:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:15 INFO - Using env: {'DISPLAY': ':0', 09:33:15 INFO - 'HOME': '/home/cltbld', 09:33:15 INFO - 'LANG': 'en_US.UTF-8', 09:33:15 INFO - 'LANGUAGE': 'en_US:en', 09:33:15 INFO - 'LOGNAME': 'cltbld', 09:33:15 INFO - 'MAIL': '/var/mail/cltbld', 09:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:15 INFO - 'MOZ_NO_REMOTE': '1', 09:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:15 INFO - 'NO_EM_RESTART': '1', 09:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:15 INFO - 'PWD': '/builds/slave/test', 09:33:15 INFO - 'SHELL': '/bin/bash', 09:33:15 INFO - 'SHLVL': '1', 09:33:15 INFO - 'TERM': 'linux', 09:33:15 INFO - 'TMOUT': '86400', 09:33:15 INFO - 'USER': 'cltbld', 09:33:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:15 INFO - '_': '/tools/buildbot/bin/python'} 09:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:18 INFO - Downloading docopt-0.6.1.tar.gz 09:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:18 INFO - Running setup.py install for blobuploader 09:33:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:18 INFO - Running setup.py install for requests 09:33:18 INFO - Running setup.py install for docopt 09:33:18 INFO - Successfully installed blobuploader requests docopt 09:33:18 INFO - Cleaning up... 09:33:18 INFO - Return code: 0 09:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:18 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 09:33:18 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 09:33:18 INFO - Using env: {'DISPLAY': ':0', 09:33:18 INFO - 'HOME': '/home/cltbld', 09:33:18 INFO - 'LANG': 'en_US.UTF-8', 09:33:18 INFO - 'LANGUAGE': 'en_US:en', 09:33:18 INFO - 'LOGNAME': 'cltbld', 09:33:18 INFO - 'MAIL': '/var/mail/cltbld', 09:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:18 INFO - 'MOZ_NO_REMOTE': '1', 09:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:18 INFO - 'NO_EM_RESTART': '1', 09:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:18 INFO - 'PWD': '/builds/slave/test', 09:33:18 INFO - 'SHELL': '/bin/bash', 09:33:18 INFO - 'SHLVL': '1', 09:33:18 INFO - 'TERM': 'linux', 09:33:18 INFO - 'TMOUT': '86400', 09:33:18 INFO - 'USER': 'cltbld', 09:33:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:18 INFO - '_': '/tools/buildbot/bin/python'} 09:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:18 INFO - Running setup.py (path:/tmp/pip-BciYKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:19 INFO - Running setup.py (path:/tmp/pip-0c97sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:19 INFO - Running setup.py (path:/tmp/pip-AppOb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:19 INFO - Running setup.py (path:/tmp/pip-Ld3Ue8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:19 INFO - Running setup.py (path:/tmp/pip-zfNk92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:19 INFO - Running setup.py (path:/tmp/pip-F0NlGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:19 INFO - Running setup.py (path:/tmp/pip-Q8rSE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:19 INFO - Running setup.py (path:/tmp/pip-Wj3nEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:19 INFO - Running setup.py (path:/tmp/pip-0QYTPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:19 INFO - Running setup.py (path:/tmp/pip-WTlJTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:19 INFO - Running setup.py (path:/tmp/pip-G8zNVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:19 INFO - Running setup.py (path:/tmp/pip-AWZisr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:19 INFO - Running setup.py (path:/tmp/pip-8FGP4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:19 INFO - Running setup.py (path:/tmp/pip-EQSMXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:19 INFO - Running setup.py (path:/tmp/pip-fAd6EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:20 INFO - Running setup.py (path:/tmp/pip-L1uot1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:20 INFO - Running setup.py (path:/tmp/pip-Xhcib7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:20 INFO - Running setup.py install for manifestparser 09:33:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Running setup.py install for mozcrash 09:33:20 INFO - Running setup.py install for mozdebug 09:33:20 INFO - Running setup.py install for mozdevice 09:33:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Running setup.py install for mozfile 09:33:20 INFO - Running setup.py install for mozhttpd 09:33:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Running setup.py install for mozinfo 09:33:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Running setup.py install for mozInstall 09:33:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:20 INFO - Running setup.py install for mozleak 09:33:21 INFO - Running setup.py install for mozlog 09:33:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Running setup.py install for moznetwork 09:33:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Running setup.py install for mozprocess 09:33:21 INFO - Running setup.py install for mozprofile 09:33:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Running setup.py install for mozrunner 09:33:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Running setup.py install for mozscreenshot 09:33:21 INFO - Running setup.py install for moztest 09:33:21 INFO - Running setup.py install for mozversion 09:33:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:21 INFO - Cleaning up... 09:33:21 INFO - Return code: 0 09:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:21 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')]} 09:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:21 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')]} 09:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:21 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:21 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 09:33:21 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 09:33:21 INFO - Using env: {'DISPLAY': ':0', 09:33:21 INFO - 'HOME': '/home/cltbld', 09:33:21 INFO - 'LANG': 'en_US.UTF-8', 09:33:21 INFO - 'LANGUAGE': 'en_US:en', 09:33:21 INFO - 'LOGNAME': 'cltbld', 09:33:21 INFO - 'MAIL': '/var/mail/cltbld', 09:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:21 INFO - 'MOZ_NO_REMOTE': '1', 09:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:21 INFO - 'NO_EM_RESTART': '1', 09:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:21 INFO - 'PWD': '/builds/slave/test', 09:33:21 INFO - 'SHELL': '/bin/bash', 09:33:21 INFO - 'SHLVL': '1', 09:33:21 INFO - 'TERM': 'linux', 09:33:21 INFO - 'TMOUT': '86400', 09:33:21 INFO - 'USER': 'cltbld', 09:33:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:21 INFO - '_': '/tools/buildbot/bin/python'} 09:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:22 INFO - Running setup.py (path:/tmp/pip-oj_kjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:22 INFO - Running setup.py (path:/tmp/pip-cCAm8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:22 INFO - Running setup.py (path:/tmp/pip-ny39Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:22 INFO - Running setup.py (path:/tmp/pip-Z_VT8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:22 INFO - Running setup.py (path:/tmp/pip-HZy63d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:22 INFO - Running setup.py (path:/tmp/pip-fWDxmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:22 INFO - Running setup.py (path:/tmp/pip-ZUTXsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:22 INFO - Running setup.py (path:/tmp/pip-VK3ytl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:22 INFO - Running setup.py (path:/tmp/pip-gmEQSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:22 INFO - Running setup.py (path:/tmp/pip-0mBfe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:22 INFO - Running setup.py (path:/tmp/pip-1umrc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:22 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)) 09:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:22 INFO - Running setup.py (path:/tmp/pip-4LLhgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:23 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)) 09:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:23 INFO - Running setup.py (path:/tmp/pip-cxfIH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:23 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)) 09:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:23 INFO - Running setup.py (path:/tmp/pip-R1tqdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:23 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)) 09:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:23 INFO - Running setup.py (path:/tmp/pip-tm5xvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:23 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)) 09:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:23 INFO - Running setup.py (path:/tmp/pip-etAau7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:23 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)) 09:33:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:23 INFO - Running setup.py (path:/tmp/pip-BUD7iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:23 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)) 09:33:23 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:23 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:23 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)) 09:33:23 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)) 09:33:23 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)) 09:33:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:25 INFO - Downloading blessings-1.6.tar.gz 09:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:25 INFO - Installing collected packages: blessings 09:33:25 INFO - Running setup.py install for blessings 09:33:25 INFO - Successfully installed blessings 09:33:25 INFO - Cleaning up... 09:33:25 INFO - Return code: 0 09:33:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:25 INFO - Reading from file tmpfile_stdout 09:33:25 INFO - Current package versions: 09:33:25 INFO - argparse == 1.2.1 09:33:25 INFO - blessings == 1.6 09:33:25 INFO - blobuploader == 1.2.4 09:33:25 INFO - docopt == 0.6.1 09:33:25 INFO - manifestparser == 1.1 09:33:25 INFO - mozInstall == 1.12 09:33:25 INFO - mozcrash == 0.16 09:33:25 INFO - mozdebug == 0.1 09:33:25 INFO - mozdevice == 0.48 09:33:25 INFO - mozfile == 1.2 09:33:25 INFO - mozhttpd == 0.7 09:33:25 INFO - mozinfo == 0.9 09:33:25 INFO - mozleak == 0.1 09:33:25 INFO - mozlog == 3.1 09:33:25 INFO - moznetwork == 0.27 09:33:25 INFO - mozprocess == 0.22 09:33:25 INFO - mozprofile == 0.28 09:33:25 INFO - mozrunner == 6.11 09:33:25 INFO - mozscreenshot == 0.1 09:33:25 INFO - mozsystemmonitor == 0.0 09:33:25 INFO - moztest == 0.7 09:33:25 INFO - mozversion == 1.4 09:33:25 INFO - psutil == 3.1.1 09:33:25 INFO - requests == 1.2.3 09:33:25 INFO - wsgiref == 0.1.2 09:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:25 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 09:33:25 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 09:33:25 INFO - Using env: {'DISPLAY': ':0', 09:33:25 INFO - 'HOME': '/home/cltbld', 09:33:25 INFO - 'LANG': 'en_US.UTF-8', 09:33:25 INFO - 'LANGUAGE': 'en_US:en', 09:33:25 INFO - 'LOGNAME': 'cltbld', 09:33:25 INFO - 'MAIL': '/var/mail/cltbld', 09:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:25 INFO - 'MOZ_NO_REMOTE': '1', 09:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:25 INFO - 'NO_EM_RESTART': '1', 09:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:25 INFO - 'PWD': '/builds/slave/test', 09:33:25 INFO - 'SHELL': '/bin/bash', 09:33:25 INFO - 'SHLVL': '1', 09:33:25 INFO - 'TERM': 'linux', 09:33:25 INFO - 'TMOUT': '86400', 09:33:25 INFO - 'USER': 'cltbld', 09:33:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:25 INFO - '_': '/tools/buildbot/bin/python'} 09:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 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)) 09:33:25 INFO - Cleaning up... 09:33:25 INFO - Return code: 0 09:33:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:25 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 09:33:25 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 09:33:25 INFO - Using env: {'DISPLAY': ':0', 09:33:25 INFO - 'HOME': '/home/cltbld', 09:33:25 INFO - 'LANG': 'en_US.UTF-8', 09:33:25 INFO - 'LANGUAGE': 'en_US:en', 09:33:25 INFO - 'LOGNAME': 'cltbld', 09:33:25 INFO - 'MAIL': '/var/mail/cltbld', 09:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:25 INFO - 'MOZ_NO_REMOTE': '1', 09:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:25 INFO - 'NO_EM_RESTART': '1', 09:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:25 INFO - 'PWD': '/builds/slave/test', 09:33:25 INFO - 'SHELL': '/bin/bash', 09:33:25 INFO - 'SHLVL': '1', 09:33:25 INFO - 'TERM': 'linux', 09:33:25 INFO - 'TMOUT': '86400', 09:33:25 INFO - 'USER': 'cltbld', 09:33:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:25 INFO - '_': '/tools/buildbot/bin/python'} 09:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:26 INFO - Downloading/unpacking jsonschema 09:33:26 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 09:33:26 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 09:33:26 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 09:33:26 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 09:33:26 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 09:33:26 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 09:33:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 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 09:33:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:28 INFO - warning: no files found matching '*.txt' 09:33:28 INFO - no previously-included directories found matching 'build' 09:33:28 INFO - no previously-included directories found matching 'dist' 09:33:28 INFO - no previously-included directories found matching '.git*' 09:33:28 INFO - Installing collected packages: jsonschema, functools32 09:33:28 INFO - Running setup.py install for functools32 09:33:28 INFO - warning: no files found matching '*.txt' 09:33:28 INFO - no previously-included directories found matching 'build' 09:33:28 INFO - no previously-included directories found matching 'dist' 09:33:28 INFO - no previously-included directories found matching '.git*' 09:33:28 INFO - Successfully installed jsonschema functools32 09:33:28 INFO - Cleaning up... 09:33:28 INFO - Return code: 0 09:33:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:33:28 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')]} 09:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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')]} 09:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:28 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 0x7f38fd309f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfad410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', '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 09:33:28 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 09:33:28 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 09:33:28 INFO - Using env: {'DISPLAY': ':0', 09:33:28 INFO - 'HOME': '/home/cltbld', 09:33:28 INFO - 'LANG': 'en_US.UTF-8', 09:33:28 INFO - 'LANGUAGE': 'en_US:en', 09:33:28 INFO - 'LOGNAME': 'cltbld', 09:33:28 INFO - 'MAIL': '/var/mail/cltbld', 09:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:28 INFO - 'MOZ_NO_REMOTE': '1', 09:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:28 INFO - 'NO_EM_RESTART': '1', 09:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:28 INFO - 'PWD': '/builds/slave/test', 09:33:28 INFO - 'SHELL': '/bin/bash', 09:33:28 INFO - 'SHLVL': '1', 09:33:28 INFO - 'TERM': 'linux', 09:33:28 INFO - 'TMOUT': '86400', 09:33:28 INFO - 'USER': 'cltbld', 09:33:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:28 INFO - '_': '/tools/buildbot/bin/python'} 09:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:28 INFO - Downloading/unpacking flake8 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 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 09:33:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:33:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:33:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 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 09:33:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:33:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:31 INFO - no previously-included directories found matching 'docs/_build' 09:33:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:33:31 INFO - Running setup.py install for pep8 09:33:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:31 INFO - no previously-included directories found matching 'docs/_build' 09:33:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:33:31 INFO - Cleaning up... 09:33:31 INFO - Return code: 0 09:33:31 INFO - Running post-action listener: _resource_record_post_action 09:33:31 INFO - Running post-action listener: _start_resource_monitoring 09:33:31 INFO - Starting resource monitoring. 09:33:31 INFO - ##### 09:33:31 INFO - ##### Running install step. 09:33:31 INFO - ##### 09:33:31 INFO - Running pre-action listener: _resource_record_pre_action 09:33:31 INFO - Running main action method: install 09:33:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:31 INFO - Reading from file tmpfile_stdout 09:33:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:32 INFO - Reading from file tmpfile_stdout 09:33:32 INFO - Output received: 09:33:32 INFO - Usage: mozinstall [options] installer 09:33:32 INFO - Options: 09:33:32 INFO - -h, --help show this help message and exit 09:33:32 INFO - -d DEST, --destination=DEST 09:33:32 INFO - Directory to install application into. [default: 09:33:32 INFO - "/builds/slave/test"] 09:33:32 INFO - --app=APP Application being installed. [default: firefox] 09:33:32 INFO - mkdir: /builds/slave/test/build/application 09:33:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:33:47 INFO - Reading from file tmpfile_stdout 09:33:47 INFO - Output received: 09:33:47 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:47 INFO - Running post-action listener: _resource_record_post_action 09:33:47 INFO - ##### 09:33:47 INFO - ##### Running run-tests step. 09:33:47 INFO - ##### 09:33:47 INFO - Running pre-action listener: _resource_record_pre_action 09:33:47 INFO - Running main action method: run_tests 09:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:47 INFO - Python 2.7.3 09:33:47 INFO - Return code: 0 09:33:47 INFO - grabbing minidump binary from tooltool 09:33: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')]} 09:33:47 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 0x103c160>, '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 0x103d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:47 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 09:33:47 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 09:33:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:48 INFO - Return code: 0 09:33:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:33:49 INFO - Return code: 0 09:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 09:33:49 INFO - Using env: {'DISPLAY': ':0', 09:33:49 INFO - 'HOME': '/home/cltbld', 09:33:49 INFO - 'LANG': 'en_US.UTF-8', 09:33:49 INFO - 'LANGUAGE': 'en_US:en', 09:33:49 INFO - 'LOGNAME': 'cltbld', 09:33:49 INFO - 'MAIL': '/var/mail/cltbld', 09:33:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:49 INFO - 'MOZ_NO_REMOTE': '1', 09:33:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:49 INFO - 'NO_EM_RESTART': '1', 09:33:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:49 INFO - 'PWD': '/builds/slave/test', 09:33:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:49 INFO - 'SHELL': '/bin/bash', 09:33:49 INFO - 'SHLVL': '1', 09:33:49 INFO - 'TERM': 'linux', 09:33:49 INFO - 'TMOUT': '86400', 09:33:49 INFO - 'USER': 'cltbld', 09:33:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552', 09:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:49 INFO - '_': '/tools/buildbot/bin/python'} 09:33:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 09:33:49 INFO - mozversion application_buildid: 20160301053641 09:33:49 INFO - mozversion application_changeset: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 09:33:49 INFO - mozversion application_display_name: Nightly 09:33:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:49 INFO - mozversion application_name: Firefox 09:33:49 INFO - mozversion application_remotingname: firefox 09:33:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:33:49 INFO - mozversion application_vendor: Mozilla 09:33:49 INFO - mozversion application_version: 47.0a1 09:33:49 INFO - mozversion platform_buildid: 20160301053641 09:33:49 INFO - mozversion platform_changeset: a4929411c0aa3ec6b727e2bc2fc050c8199c6573 09:33:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:33:49 INFO - mozversion platform_version: 47.0a1 09:33:49 INFO - using testdate: 1457026429 09:33:49 INFO - actual date: 1457026429 09:33:49 INFO - starting webserver on 'localhost:50756' 09:33:49 INFO - SUITE-START | Running 2 tests 09:33:49 INFO - TEST-START | dromaeo_css 09:33:49 INFO - operating with platform_type : linux_ 09:33:49 INFO - Initialising browser for dromaeo_css test... 09:33:49 INFO - TEST-INFO | started process 2834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6Z5F4/profile http://localhost:50756/getInfo.html) 09:33:53 INFO - PROCESS | 2834 | 09:33:53 INFO - PROCESS | 2834 | (process:2915): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:33:54 INFO - PROCESS | 2834 | __metrics Screen width/height:1600/1200 09:33:54 INFO - PROCESS | 2834 | colorDepth:24 09:33:54 INFO - PROCESS | 2834 | Browser inner width/height: 1024/697 09:33:54 INFO - PROCESS | 2834 | __metrics 09:33:55 ERROR - PROCESS | 2834 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:55 INFO - PROCESS | 2834 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:33:56 INFO - TEST-INFO | 2834: exit 0 09:33:56 INFO - Browser initialized. 09:33:56 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:56 INFO - TEST-INFO | started process 2967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6Z5F4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:57 INFO - PROCESS | 2967 | 09:33:57 INFO - PROCESS | 2967 | (process:3024): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:08 INFO - PROCESS | 2967 | RSS: Main: 161181696 09:34:08 INFO - PROCESS | 2967 | 09:34:57 INFO - PROCESS | 2967 | 1457026497728 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] 09:37:09 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:50756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50756/tests/dromaeo/cssquery-ext.html) 09:37:10 INFO - PROCESS | 2967 | RSS: Main: 170053632 09:37:10 INFO - PROCESS | 2967 | 09:40:12 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:50756/tests/dromaeo/cssquery-ext.html (next: http://localhost:50756/tests/dromaeo/cssquery-jquery.html) 09:40:12 INFO - PROCESS | 2967 | RSS: Main: 164835328 09:40:12 INFO - PROCESS | 2967 | 09:43:14 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:50756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50756/tests/dromaeo/cssquery-mootools.html) 09:43:15 INFO - PROCESS | 2967 | RSS: Main: 166506496 09:43:15 INFO - PROCESS | 2967 | 09:46:17 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:50756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50756/tests/dromaeo/cssquery-prototype.html) 09:46:17 INFO - PROCESS | 2967 | RSS: Main: 164028416 09:46:17 INFO - PROCESS | 2967 | 09:49:20 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:50756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50756/tests/dromaeo/cssquery-yui.html) 09:49:20 INFO - PROCESS | 2967 | RSS: Main: 165490688 09:49:20 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:50756/tests/dromaeo/cssquery-yui.html (next: http://localhost:50756/tests/dromaeo/cssquery-dojo.html) 09:52:23 INFO - PROCESS | 2967 | RSS: Main: 168144896 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | __start_tp_report 09:52:23 INFO - PROCESS | 2967 | _x_x_mozilla_page_load 09:52:23 INFO - PROCESS | 2967 | _x_x_mozilla_page_load_details 09:52:23 INFO - PROCESS | 2967 | |i|pagename|runs| 09:52:23 INFO - PROCESS | 2967 | |0;dojo.html;2648.854313012784;2679.9196024119283;2705.2154875086226;2714.837109773414;2728.16790878782;4444.733316001042;4545.295479200725;4559.270516717322;4592.954070459295;4594.7013444126105;4558.589726924576;4562.726236425817;4578.31325301205;4588.81644734211;4636.397268355117;4191.224623444665;4227.978860105695;4230.576942305775;4369.606735393814;4374.584414480635;4135.421041054255;4181.770002649853;4306.267934451135;4325.826966921335;4336.436263285768;4194.056337324108;4204.894877628053;4219.578042195786;4221.409002739619;4225.894352641178;4165.91668166638;4215.072684009513;4227.471566054243;4238.406623072772;4253.744775313491;4079.4900637420324;4187.2044311581;4213.620774130343;4275.209086319041;4284.036091879333;4496.100779844044;4525.592696657317;4528.773561321954;4558.908821823545;4587.42657167854;4850.5877000455;4880.072786170652;4884.169691152512;4891.046245981999;4900.632452566037;4754.453237877654;4853.17496025673;4904.411470623548;4927.063857866994;4955;4516.141933032746;4535.546445355471;4536.160810250114;4538.72767633943;4556.316552517149;4816.590589799836;4961.131801934647;4983.352164218629;4992.875178120504;5013.724245166551;4746.525347465225;4772.260299653559;4773.284007398918;4816.446108697544;4831.879203019882;4779.4264688236935;4878.268259760993;4901.828436004723;4909.582685471703;4965.428975667773;4637.420322459692;4802.8799280018275;4814.422269327633;4817.9036419271415;4882.194437917704;4787.3776409066595;4824.131656301829;4851.975740121276;4864.489228631013;4885.926711099336;4022.255882661717;4051.594840515984;4055.1889622075114;4083.4895638045246;4092.7339722917914;3454.844531996066;3532.717382609385;3538.982305088458;3557.1107223194203;3611.8194090295906;4237.766922819213;4238.258304796648;4251.681123915719;4265.722728022669;4283.828646854154;4885.022995400934;4885.462599114095;4899.632527560448;4902.975485122552;4953.083679519301;4164.12553363797;4232.047789247456;4254.553271906467;4257.467816522934;4265.957340426618;4342.544032876565;4356.3683265926265;4357.520672725997;4363.672724545671;4402.3836662867225;4621.7920193592045;4623.630109591225;4670.8365207217585;4674.415698037746;4703.905921881612;4842.975785121052;4879.707217566957;4890.24201248807;4891.315215869852;4920.163572192808;4635.188841952578;4652;4680.157571637002;4682.1806183917;4721.102990431807;4704.435467743892;4844.515548445268;4869.70781753096;4876.634252431011;4904.337914381513;4711.764411779466;4804.3273941648895;4819.6867203631655;4829.082474329866;4829.9275510868065;4724.433068031721;4745.145873742759;4752.2158843790385;4756.072565849626;4764.976175119103;4753.928691069567;4763.095011947719;4763.618910487222;4767.904641907212;4796.20862557688;4500.9099818004115;4625.676202665781;4630.6758526902795;4670.416197975253;4675.064987002545;4759.23852183649;4768.880777980439;4779.665423420466;4781.976090119666;4837.806487740451;4578.084383123455;4658.138244424792;4661.324108004388;4667.9766601166775;4705.176594096088 09:52:23 INFO - PROCESS | 2967 | |1;ext.html;467.50911542879976;477.42231899401725;493.94319653239876;498.7954938475224;530.928324676169;30748;30994.845025774895;31094.067177984667;31243.84378078112;31308.843455782717;34340.313193736176;35339.11652208689;35345.2930941381;35487.4676879847;35500.2899942001;7260.818479538014;7428.925710742905;7432.145303290136;7449.143348514936;7454.291842274975;7436.516626419266;7495.812604684872;7565.546067235983;7595.202503737111;7626.122995855492;7532.698692052311;7536.171021187665;7547.924520754805;7599.848003039936;7619.276168763986;7364.742234021837;7411.221821708697;7415.110186777594;7425.777226683181;7507.962460187691;7485.476016678835;7654.043244594426;7675.19410461899;7720.459567830254;7727.574983375912;32397.51403728946;32452.675473245203;32645;32680.673193268;32806.83596582025;2624.134035768192;2696.7438093381097;2719.252205643444;2724.2916841621322;3187.2589373810174;26452.8677356612;26521.336966575796;26543.336416589547;26681.46637067248;27581.31046723828;3261.575995120619;3275.279438523521;3293.4071867063917;3298.2743796365003;3360.9495857562156;208655;210285;210446;211277;211925.99999999846;36167.63832361696;47791.522084779404;48113.278300825514;48405.27392089122;48454.27318590224;34464.82767586196;34494.31011379758;34589.82705086459;34629.82685086609;34948.47577286343;12342.074344424203;12514.49942002328;12527.624171274876;12567.18313309632;12607.873921260854;9171.128742769426;9188.770280742901;9233.399829011092;9237.815243695088;9238.86141707875;11931.940340298417;11979.52081916731;12378.133530652947;12446.937765311297;12544.623661290176;4999.950000500021;5022.547970682656;5079.619028572872;5121.308623335876;5151.407588127338;749.7375918428506;790.7351037402419;805.8630032894422;807.6204184033495;837.5895811052541;24520.754792452204;24778;24981;25285.620715689278;25551.61672574913;826.7271800306005;907.2061945797427;939.5490164720973;966.1787480641399;1025.1132770153763;12858.292793896238;13290.3354832258;13495.527656531975;13517.459301627825;13559.186448813103;258417;260754;261182;263059;265171;41497.1700565987;42022.78988605038;42183.578164218576;42214.788926055175;42290.51983180574;967.2407160379069;1017.2472370445817;1041.2867185977477;1093.5188517052472;1094.8631421072366;24283.51432971366;24815;25452.363690907874;25763.6135457972;25859.577723225404;37031.814840925625;37371.25257494889;37478.62521374752;37522.8123859379;37687;246176;246966;247979;248010;248314;27873.655161379953;28073;28371.148865534065;28374.716252837206;28765.424691506472;36567.26865462729;36664.45003324899;36956.076098097765;37102.44346334861;37296.81351593225;26521.469570608093;26819.597706034816;27179.320516987234;27418.17745467639;28184.29539261535;31569;31666;31687.841560792047;31948;32091.839540802146;31670.366592668477;31680.841595791873;31895.840520797246;35165.47251791276;36098;31100.68899310978;33639;34063.4890476648;34186.31627367389;34239.48640770341;27254.318642034108;27585.86207068952;27942.3014424641;28136;28175.295617609725 09:52:23 INFO - PROCESS | 2967 | |2;jquery.html;303.5310445361916;306.7990466244611;311.4363002964634;316.18897527841085;317.85855294394;11158;14570.635734106652;14937.775933360994;15000.399984000627;15095.92452037741;13397.062205645609;13656.112352697093;13677.110987785813;13712.58862234132;13947.860521394783;4719;4970.900581988358;4971.130052240844;4982.975085124569;4988.875278118058;4722.1028004679;4873.415190177166;4879.731614761186;4919.60643148549;4955.0089982003565;4841.6852904561265;4887.584555312803;4890.3642526471685;4894.216925291954;4898.191798353268;4959.628027897904;5716.771329146829;5730.140478928173;5739.540836733093;5742.598018138732;5021.07110184617;5036.420811606676;5055.266986286968;5060.165072762989;5085.821996230151;11018.11855051594;11280.774384512346;11285.379304138269;11314;11339.37633430161;1785.7053586158397;1826.7899191593003;1843.7142242952364;1844.6402951424477;1871.6724573199635;8750.868736968887;8758;9333.346665733401;9717;11319.094472442184;1681.941132060372;1700.6173610937565;1734.4363081998401;1771.6899542579997;1796.4341232511717;52173.73913130448;55263;55888;56039;57075;9451.905480945103;9467.337286389886;9499.572519236652;9630.181434578139;9682.031796820402;11994.400279985966;12024.398780060961;12059.397030148457;12100.213486123374;12101.273923564439;6322;6530.869382612321;6621.437177839841;6646.26891041985;6662.367075127855;6169.136320915076;6239.719212635442;6317.96841015792;6355.904661430082;6405.647689377036;3712.7586706863967;3810.994594863864;3872.3223435898603;3878.5733569307354;4117.032497363117;1640.7374820028738;1656.3209084275388;1702.829717028312;1741.8171092035154;1742.599202183505;791.2245998921089;811.5942028985507;852.4033176776281;870.8563087090686;929.7210836748948;14560.199189044704;14782.704345913022;14796.926015369854;15142.470013549473;15307.15810630426;784.3607459920147;790.4822341366414;797.143071198464;845.7166849105496;846.7205822078822;8473.322134229247;8508.489490630458;8587.270082043096;8644.740657780276;8656.783580410414;361032;361174;362826;363067;370763;59255.70372148198;60341;61055.69472152611;62306.37693623006;62663;813.7477382011477;817.7546735979302;829.2371018662844;836.8786525953702;844.438448431786;13567.932160339134;13662.248576328;13794.103383280055;13838.100523465942;14070.155790652594;29286;29750.404991900472;30396.696033039385;30976.380472390876;31279.37441251208;39875.40186897141;41360.58639413567;42362.788186058875;42629;42678.57321426746;6670.332966703291;6734.427573656294;6952.200496942714;7114.964425177841;7156.499045066796;9750.171235445066;10066.245031622511;10135.949320253352;10574.10120139766;10726;9399.718008459757;9400.764980875532;9474.336796424184;9497.67307009787;9512.714618561178;9059.592318345822;9190.126937940884;9195.264378849542;9287;9312.627494900127;8778.561071946506;8938.37431379797;9116.316276279438;9386.76533086651;9872.555734992085;6899.965500172668;7019.6490175492045;7033.613151276524;7141.9642901785155;7268.454865885185;7657.617119143909;8909.73270801877;9522.95238523803;9554;9957 09:52:23 INFO - PROCESS | 2967 | |3;mootools.html;1118.7426891814885;1120.8991190792826;1121.7251773315538;1254.6737848159476;1312.6455856918637;5963;6633.502487313447;6855.485838562103;6982.650867456619;7008.439324854012;6807.863842723143;6862.897056544143;6863.725450981955;6870.07254020707;6963.094797676307;1969.9310524131695;1991.4224874786294;1994.0627904884755;1997.0314397517266;1998.580298137393;1869.7849747279033;1923.0384807596201;1925.0855843474378;1929.0354822588706;1938.2150229157214;1926.9325573604926;1966.1250743419184;1970.5369238229005;1975.693767466045;1977.4561995451222;2024.8380129589598;2043.9693404598943;2045.1308194017483;2050.3643870400224;2063.1025503905776;1961.264525802824;1963.136220063182;1974.4175468236904;2003.6994450832347;2011.8189362957257;7068.752593659197;7071.8939215911805;7072.045273888062;7077.71689132434;7084.504084714072;3906.570277269498;4022.577629348935;4022.9942514371405;4034.515858097018;4040.474738284004;2433.9513209735883;2459.9016039358403;2513.082724805433;2515.559777039011;2598.974010259892;775.2092865277442;782.7495201535511;809.2231457800518;824.2869917521301;838.1241602525375;9483.715488535356;9538.14156725891;9539.90460095397;9553.952230238805;9563.808723825554;3554.1647712787476;3627.093226693327;3715.5169827922196;3722.218334149859;3724.981375093161;8121.959390203011;8178.345732341399;8186.918130818734;8204.8359032819;8210.876836847452;3943.743656662308;3953.723239373216;3960.7623542587535;3961.603839616015;3964.0486283291802;3060.5103183490533;3454.894433781166;3538.911527211789;3542.415501442233;3549.8580056797437;3131.6242050953574;3193.2655489237604;3218.806871587712;3220.951685724716;3233.547303377529;996.1283876607968;1022.8312328465869;1027.8406846938738;1028.28534168752;1037.0977249792577;784.2314531758794;798.4331124901269;804.0994086623019;903.1014140929817;988.8665030220972;6130.356312587114;6140.907886381708;6151.169592105098;6162.845928851814;6203.286622038523;397.34438177008167;398.8484375937125;1025.3540269630234;1061.4374381577777;1073.2594509788378;4799.088173247072;4827.927581086286;4931.778069986859;4956.35567376246;5011.824586139468;7896.447248692536;8126.187381261827;8143.470674406263;8165.428420010542;8171.264586187272;7879.33025692811;7942.483738557091;8042.638081286356;8047.919520804717;8051.074126475413;6479.157709497829;6531.0856480092825;6588.86822263552;6629.403353698191;6632.204135503771;6161.938380616316;6168.383161683796;6178.567500275118;6206.06908963659;6222.346653601307;7057;7224.313690199423;7252.927470725436;7386.852262954603;7441.55350678961;7381.483296169216;7437.144728356308;7510.586917719578;7527.736529221451;7540.434467414856;5799.623024503394;5815.79644712433;5848.2689663792025;5868.735906884115;5961.791337303347;6370.968145159244;6390.009548519801;6398.776042838478;6441.903371449525;6457.903131452938;5640.802571909963;5800.1299805029585;5851.063829787214;5866.794662186803;6007.4893634039845;5704.372519022987;5839.328477225174;5928.822135335947;5940;5992.550558708202;6003.459688628044;6057.666828324484;6059;6090.969545152246;6119.908201377072;5809.593328466966;5829.329627092939;5849.181114644039;5854;5873.236479257669;5814.970925145347;5838.153467747238;5871.853203669943;5889.823305300848;5901.380355062656 09:52:23 INFO - PROCESS | 2967 | |4;prototype.html;278.27509338174053;282.6721003635783;284.7258518131362;284.75987076282775;287.2388171345933;5531.585131115163;5556.555475561955;5612.382637909826;5640.238567793347;5640.915386269199;5330.1205301125365;5513.476219759116;5521.641093328941;5528.115501519757;5533.197686335479;3985.541662708782;4128.463299771026;4135.937960930589;4139.027328577789;4165.500139983191;4084.65280451162;4104.466419365478;4118.485189351331;4129.587041295861;4136.296829538986;4071.87784366468;4075.1458086570537;4078.8980275493054;4080.1431699343175;4082.4080508326424;4101.794910254505;4108.609682080198;4110.815013324393;4117.114820313647;4117.649999750025;3527.382708026111;3530.8058056806867;3530.894073177809;3536.6993805526563;3540.026492714524;5294.047071527124;5297.4437684043005;5307.973460132714;5308.309919710451;5308.362996440414;4697.107549565571;4706.011737535087;4707.199776038047;4707.952920470786;4711.4346278446465;5548.805791797308;5739.82780516581;5746.827595172152;5765.221695071195;5769.653820770767;3850.7689538627774;3851.73037887348;3854.3447613905705;3854.3447613905705;3863.864764733221;5990.101484777319;6044.546659000593;6056.636601803862;6061.575689701766;6066.878662426727;3903.6681882040343;3913.5108111486065;3922.2547715933883;3922.5292964844402;3935.0162459385156;3975.1652153048185;3975.960240397559;3979.5622481527007;3986.980065099714;3991.082051128257;4609.838655647036;4620;4620.607248383858;4655.557722016403;4665.626749860071;5517.144842549411;5763.510101641407;5791.146833013395;5800.0429929062075;5830.854228644318;1353.3842101843834;1404.6979899321695;1409.323524708146;1410.153907655419;1416.044170185121;910.9863352049724;917.3349321741684;925.8750068740634;935.1910597333258;936.3071327217809;5043.218301163325;5047.924281135786;5049.267856160836;5052.974735126374;5063.822766203165;5942.257217847769;5971.581989260797;6020.518358531307;6025.638461692312;6055.061465472859;4985.8005679772405;5027.547520723152;5038.395392552917;5051.722155281494;5055.418626857959;3160.225744692565;3231.2891163943896;3242.578464799561;3264.853081611333;3268.313654132659;5628.380878103405;5694.60137790359;5695.572832037614;5709.22925405065;5711.686312148229;6178.227721534809;6206.038064100072;6214.9689251554355;6218.844528886723;6227.346128656516;5685.971570142206;5705.71471426427;5720.482987485493;5725.2843394575675;5752.453516915886;5850.356460789395;5884.904352854963;6101.877962440815;6105.542084343603;6194.225721784777;5800.854978625568;5936.28764548257;5948.73230704628;5950.494207992196;5950.553708471795;5607.102863541813;5713.314402271754;5720.74256658443;5726.742296596746;5730.111832665943;3910.7262491625315;3955.5253369595835;3961.2869683457257;3962.187751510991;3975;6053.697315134314;6058.90911636317;6062.575619706578;6063.848403789941;6071;5665.858353541194;5806.216160818404;5836.358000620014;5850.356460789395;5861.648301101947;5847.26909136358;5872.471477567039;5875.794347197828;5878.794242201502;5922.644641321534;5650.406707295675;5657.32112146545;5687.260656114679;5698.2592263005545;5714.457126572969;5830.970845145747;5857.941420585739;5869.295684517885;5873.207117039145;5877.118432235199;5629.437056294338;5678.829635110953;5682.857928551819;5690.630109043064;5695.658260504383 09:52:23 INFO - PROCESS | 2967 | |5;yui.html;511.1719015195384;546.1725485888879;594.658071608825;595.0716881664603;599.8860216558853;10456.372617642937;10523;10524.579016839318;10574.471276436187;10667.733306667336;9482.857757133648;9495.24038076954;9511.857322140157;9559.044095590454;9595.66415175469;643.9098526206335;658.2298710508717;661.0843981086182;662.2251965200727;663.6482664187988;652.1098700274139;656.0814859197114;659.0575477067791;661.7816120680164;662.3078882567728;680.5916450129932;685.8525417035337;689.600031981452;689.9896501552481;690.7237105157927;675.6452862247335;679.8538314262407;680.6460640466954;680.8263892707353;681.2744427185032;503.48141414343286;508.4407152132662;509.2666560153367;509.5134146889748;509.67126203598474;9182.17360437564;9214.493202873839;9229.53852307382;9289.210417114553;9296.8605470918;8904.821903561957;9009.144131307516;9102.590383432762;9255;9479.620815167385;7700.3069723724575;7869.488483248628;7973.641186146638;7977.202279772035;8052.758417247492;3042.3306872488015;3057.877684892602;3076.446239676857;3089.073278016586;3160.604924384452;38171.80914095439;38308.425373619415;38453;39010.41484377737;39760.60239397627;8655.826883462296;8716.128387161232;8716.869246961302;8739.781505462413;8794.692185773467;13596.728065438636;13624.863751362558;13663.248521331423;13750.931245343909;13757.931210344084;6004.279486461653;6076.665783381956;6114.0828875669;6176.81469555914;6340;3416.79499230047;3432.1419645088727;3454.4300190468794;3519.859205631797;3543.706711249139;2373.655819906104;2414.167112346238;2428.3200703802963;2431.598786200257;2434.0628857889487;456.8720758187713;464.8698364457957;475.995240047602;476.4282860567333;477.8661974647104;485.9514048595183;498.3511892696256;503.67764630636424;509.7706032285486;521.4733119549206;6097.237845269341;6422.197225346832;6455.903161452582;6470.64411457365;6563.704633291513;482.74897053531964;491.46160083170736;491.8598199513193;501.83188631808025;527.1354977836352;3103.177657920653;3236.996531075374;3262.5758651375168;3279.7048265655726;3352.782069165545;46209.30686039712;47626;48103;48308.5169148311;48576.5142348579;41569;42092;42425.57574424278;42737.786311068245;43002.56997430048;37208;42789.786051070165;43715.78142109269;44399.55600443954;44706.77646611811;7414.406847452299;7443.590602516913;7506.3244308012545;7606.543607383574;7631.847363052819;29996.550051749677;30940.845295773375;31272.687273126976;31872.681273186972;32060.839695801373;36126.63873361338;37871.81064094662;38173.80913095417;38541.4218786724;39390.212195756496;8852.557372131496;8892.955535222542;8934.687285944961;8942;8977.23693486061;8804.867926980973;8964.910350896407;9007.459552426875;9009;9278.304127190622;8417.494950303002;8521.701740439055;8622.439541429787;8723.432976856484;8724.258438032584;8258.339332853477;8465.407421480684;8522.23299902987;8538.14618538166;8734;8049.356051515982;8259.669613215405;8517.829643407222;8529.914700852913;8537.103604121477;7208.531445456028;7235.2402997684485;7387.741429049957;7547.773566793005;7609.277118673717;6965.7561985332295;6980.7905762827195;7011.26381729911;7108.751193708195;7233 09:52:23 INFO - PROCESS | 2967 | __end_tp_report 09:52:23 INFO - PROCESS | 2967 | __start_cc_report 09:52:23 INFO - PROCESS | 2967 | _x_x_mozilla_cycle_collect,360 09:52:23 INFO - PROCESS | 2967 | __end_cc_report 09:52:23 INFO - PROCESS | 2967 | __startTimestamp1457027543266__endTimestamp 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | ------- Summary: start ------- 09:52:23 INFO - PROCESS | 2967 | Number of tests: 6 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | [#0] dojo.html Cycles:165 Average:4512.06 Median:4637.42 stddev:452.25 (9.8%) stddev-sans-first:429.37 09:52:23 INFO - PROCESS | 2967 | Values: 2648.9 2679.9 2705.2 2714.8 2728.2 4444.7 4545.3 4559.3 4593.0 4594.7 4558.6 4562.7 4578.3 4588.8 4636.4 4191.2 4228.0 4230.6 4369.6 4374.6 4135.4 4181.8 4306.3 4325.8 4336.4 4194.1 4204.9 4219.6 4221.4 4225.9 4165.9 4215.1 4227.5 4238.4 4253.7 4079.5 4187.2 4213.6 4275.2 4284.0 4496.1 4525.6 4528.8 4558.9 4587.4 4850.6 4880.1 4884.2 4891.0 4900.6 4754.5 4853.2 4904.4 4927.1 4955.0 4516.1 4535.5 4536.2 4538.7 4556.3 4816.6 4961.1 4983.4 4992.9 5013.7 4746.5 4772.3 4773.3 4816.4 4831.9 4779.4 4878.3 4901.8 4909.6 4965.4 4637.4 4802.9 4814.4 4817.9 4882.2 4787.4 4824.1 4852.0 4864.5 4885.9 4022.3 4051.6 4055.2 4083.5 4092.7 3454.8 3532.7 3539.0 3557.1 3611.8 4237.8 4238.3 4251.7 4265.7 4283.8 4885.0 4885.5 4899.6 4903.0 4953.1 4164.1 4232.0 4254.6 4257.5 4266.0 4342.5 4356.4 4357.5 4363.7 4402.4 4621.8 4623.6 4670.8 4674.4 4703.9 4843.0 4879.7 4890.2 4891.3 4920.2 4635.2 4652.0 4680.2 4682.2 4721.1 4704.4 4844.5 4869.7 4876.6 4904.3 4711.8 4804.3 4819.7 4829.1 4829.9 4724.4 4745.1 4752.2 4756.1 4765.0 4753.9 4763.1 4763.6 4767.9 4796.2 4500.9 4625.7 4630.7 4670.4 4675.1 4759.2 4768.9 4779.7 4782.0 4837.8 4578.1 4658.1 4661.3 4668.0 4705.2 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | [#1] ext.html Cycles:180 Average:38156.39 Median:18050.12 stddev:62805.57 (348.0%) stddev-sans-first:62918.00 09:52:23 INFO - PROCESS | 2967 | Values: 467.5 477.4 493.9 498.8 530.9 30748.0 30994.8 31094.1 31243.8 31308.8 34340.3 35339.1 35345.3 35487.5 35500.3 7260.8 7428.9 7432.1 7449.1 7454.3 7436.5 7495.8 7565.5 7595.2 7626.1 7532.7 7536.2 7547.9 7599.8 7619.3 7364.7 7411.2 7415.1 7425.8 7508.0 7485.5 7654.0 7675.2 7720.5 7727.6 32397.5 32452.7 32645.0 32680.7 32806.8 2624.1 2696.7 2719.3 2724.3 3187.3 26452.9 26521.3 26543.3 26681.5 27581.3 3261.6 3275.3 3293.4 3298.3 3360.9 208655.0 210285.0 210446.0 211277.0 211926.0 36167.6 47791.5 48113.3 48405.3 48454.3 34464.8 34494.3 34589.8 34629.8 34948.5 12342.1 12514.5 12527.6 12567.2 12607.9 9171.1 9188.8 9233.4 9237.8 9238.9 11931.9 11979.5 12378.1 12446.9 12544.6 5000.0 5022.5 5079.6 5121.3 5151.4 749.7 790.7 805.9 807.6 837.6 24520.8 24778.0 24981.0 25285.6 25551.6 826.7 907.2 939.5 966.2 1025.1 12858.3 13290.3 13495.5 13517.5 13559.2 258417.0 260754.0 261182.0 263059.0 265171.0 41497.2 42022.8 42183.6 42214.8 42290.5 967.2 1017.2 1041.3 1093.5 1094.9 24283.5 24815.0 25452.4 25763.6 25859.6 37031.8 37371.3 37478.6 37522.8 37687.0 246176.0 246966.0 247979.0 248010.0 248314.0 27873.7 28073.0 28371.1 28374.7 28765.4 36567.3 36664.5 36956.1 37102.4 37296.8 26521.5 26819.6 27179.3 27418.2 28184.3 31569.0 31666.0 31687.8 31948.0 32091.8 31670.4 31680.8 31895.8 35165.5 36098.0 31100.7 33639.0 34063.5 34186.3 34239.5 27254.3 27585.9 27942.3 28136.0 28175.3 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | [#2] jquery.html Cycles:180 Average:21422.36 Median:5004.97 stddev:59655.19 (1191.9%) stddev-sans-first:59801.46 09:52:23 INFO - PROCESS | 2967 | Values: 303.5 306.8 311.4 316.2 317.9 11158.0 14570.6 14937.8 15000.4 15095.9 13397.1 13656.1 13677.1 13712.6 13947.9 4719.0 4970.9 4971.1 4983.0 4988.9 4722.1 4873.4 4879.7 4919.6 4955.0 4841.7 4887.6 4890.4 4894.2 4898.2 4959.6 5716.8 5730.1 5739.5 5742.6 5021.1 5036.4 5055.3 5060.2 5085.8 11018.1 11280.8 11285.4 11314.0 11339.4 1785.7 1826.8 1843.7 1844.6 1871.7 8750.9 8758.0 9333.3 9717.0 11319.1 1681.9 1700.6 1734.4 1771.7 1796.4 52173.7 55263.0 55888.0 56039.0 57075.0 9451.9 9467.3 9499.6 9630.2 9682.0 11994.4 12024.4 12059.4 12100.2 12101.3 6322.0 6530.9 6621.4 6646.3 6662.4 6169.1 6239.7 6318.0 6355.9 6405.6 3712.8 3811.0 3872.3 3878.6 4117.0 1640.7 1656.3 1702.8 1741.8 1742.6 791.2 811.6 852.4 870.9 929.7 14560.2 14782.7 14796.9 15142.5 15307.2 784.4 790.5 797.1 845.7 846.7 8473.3 8508.5 8587.3 8644.7 8656.8 361032.0 361174.0 362826.0 363067.0 370763.0 59255.7 60341.0 61055.7 62306.4 62663.0 813.7 817.8 829.2 836.9 844.4 13567.9 13662.2 13794.1 13838.1 14070.2 29286.0 29750.4 30396.7 30976.4 31279.4 39875.4 41360.6 42362.8 42629.0 42678.6 6670.3 6734.4 6952.2 7115.0 7156.5 9750.2 10066.2 10135.9 10574.1 10726.0 9399.7 9400.8 9474.3 9497.7 9512.7 9059.6 9190.1 9195.3 9287.0 9312.6 8778.6 8938.4 9116.3 9386.8 9872.6 6900.0 7019.6 7033.6 7142.0 7268.5 7657.6 8909.7 9523.0 9554.0 9957.0 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | [#3] mootools.html Cycles:180 Average:4725.09 Median:5872.54 stddev:2508.06 (42.7%) stddev-sans-first:2500.45 09:52:23 INFO - PROCESS | 2967 | Values: 1118.7 1120.9 1121.7 1254.7 1312.6 5963.0 6633.5 6855.5 6982.7 7008.4 6807.9 6862.9 6863.7 6870.1 6963.1 1969.9 1991.4 1994.1 1997.0 1998.6 1869.8 1923.0 1925.1 1929.0 1938.2 1926.9 1966.1 1970.5 1975.7 1977.5 2024.8 2044.0 2045.1 2050.4 2063.1 1961.3 1963.1 1974.4 2003.7 2011.8 7068.8 7071.9 7072.0 7077.7 7084.5 3906.6 4022.6 4023.0 4034.5 4040.5 2434.0 2459.9 2513.1 2515.6 2599.0 775.2 782.7 809.2 824.3 838.1 9483.7 9538.1 9539.9 9554.0 9563.8 3554.2 3627.1 3715.5 3722.2 3725.0 8122.0 8178.3 8186.9 8204.8 8210.9 3943.7 3953.7 3960.8 3961.6 3964.0 3060.5 3454.9 3538.9 3542.4 3549.9 3131.6 3193.3 3218.8 3221.0 3233.5 996.1 1022.8 1027.8 1028.3 1037.1 784.2 798.4 804.1 903.1 988.9 6130.4 6140.9 6151.2 6162.8 6203.3 397.3 398.8 1025.4 1061.4 1073.3 4799.1 4827.9 4931.8 4956.4 5011.8 7896.4 8126.2 8143.5 8165.4 8171.3 7879.3 7942.5 8042.6 8047.9 8051.1 6479.2 6531.1 6588.9 6629.4 6632.2 6161.9 6168.4 6178.6 6206.1 6222.3 7057.0 7224.3 7252.9 7386.9 7441.6 7381.5 7437.1 7510.6 7527.7 7540.4 5799.6 5815.8 5848.3 5868.7 5961.8 6371.0 6390.0 6398.8 6441.9 6457.9 5640.8 5800.1 5851.1 5866.8 6007.5 5704.4 5839.3 5928.8 5940.0 5992.6 6003.5 6057.7 6059.0 6091.0 6119.9 5809.6 5829.3 5849.2 5854.0 5873.2 5815.0 5838.2 5871.9 5889.8 5901.4 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | [#4] prototype.html Cycles:180 Average:4750.86 Median:5532.39 stddev:1455.72 (26.3%) stddev-sans-first:1420.57 09:52:23 INFO - PROCESS | 2967 | Values: 278.3 282.7 284.7 284.8 287.2 5531.6 5556.6 5612.4 5640.2 5640.9 5330.1 5513.5 5521.6 5528.1 5533.2 3985.5 4128.5 4135.9 4139.0 4165.5 4084.7 4104.5 4118.5 4129.6 4136.3 4071.9 4075.1 4078.9 4080.1 4082.4 4101.8 4108.6 4110.8 4117.1 4117.6 3527.4 3530.8 3530.9 3536.7 3540.0 5294.0 5297.4 5308.0 5308.3 5308.4 4697.1 4706.0 4707.2 4708.0 4711.4 5548.8 5739.8 5746.8 5765.2 5769.7 3850.8 3851.7 3854.3 3854.3 3863.9 5990.1 6044.5 6056.6 6061.6 6066.9 3903.7 3913.5 3922.3 3922.5 3935.0 3975.2 3976.0 3979.6 3987.0 3991.1 4609.8 4620.0 4620.6 4655.6 4665.6 5517.1 5763.5 5791.1 5800.0 5830.9 1353.4 1404.7 1409.3 1410.2 1416.0 911.0 917.3 925.9 935.2 936.3 5043.2 5047.9 5049.3 5053.0 5063.8 5942.3 5971.6 6020.5 6025.6 6055.1 4985.8 5027.5 5038.4 5051.7 5055.4 3160.2 3231.3 3242.6 3264.9 3268.3 5628.4 5694.6 5695.6 5709.2 5711.7 6178.2 6206.0 6215.0 6218.8 6227.3 5686.0 5705.7 5720.5 5725.3 5752.5 5850.4 5884.9 6101.9 6105.5 6194.2 5800.9 5936.3 5948.7 5950.5 5950.6 5607.1 5713.3 5720.7 5726.7 5730.1 3910.7 3955.5 3961.3 3962.2 3975.0 6053.7 6058.9 6062.6 6063.8 6071.0 5665.9 5806.2 5836.4 5850.4 5861.6 5847.3 5872.5 5875.8 5878.8 5922.6 5650.4 5657.3 5687.3 5698.3 5714.5 5831.0 5857.9 5869.3 5873.2 5877.1 5629.4 5678.8 5682.9 5690.6 5695.7 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | [#5] yui.html Cycles:180 Average:11246.35 Median:6381.10 stddev:13601.00 (213.1%) stddev-sans-first:13615.26 09:52:23 INFO - PROCESS | 2967 | Values: 511.2 546.2 594.7 595.1 599.9 10456.4 10523.0 10524.6 10574.5 10667.7 9482.9 9495.2 9511.9 9559.0 9595.7 643.9 658.2 661.1 662.2 663.6 652.1 656.1 659.1 661.8 662.3 680.6 685.9 689.6 690.0 690.7 675.6 679.9 680.6 680.8 681.3 503.5 508.4 509.3 509.5 509.7 9182.2 9214.5 9229.5 9289.2 9296.9 8904.8 9009.1 9102.6 9255.0 9479.6 7700.3 7869.5 7973.6 7977.2 8052.8 3042.3 3057.9 3076.4 3089.1 3160.6 38171.8 38308.4 38453.0 39010.4 39760.6 8655.8 8716.1 8716.9 8739.8 8794.7 13596.7 13624.9 13663.2 13750.9 13757.9 6004.3 6076.7 6114.1 6176.8 6340.0 3416.8 3432.1 3454.4 3519.9 3543.7 2373.7 2414.2 2428.3 2431.6 2434.1 456.9 464.9 476.0 476.4 477.9 486.0 498.4 503.7 509.8 521.5 6097.2 6422.2 6455.9 6470.6 6563.7 482.7 491.5 491.9 501.8 527.1 3103.2 3237.0 3262.6 3279.7 3352.8 46209.3 47626.0 48103.0 48308.5 48576.5 41569.0 42092.0 42425.6 42737.8 43002.6 37208.0 42789.8 43715.8 44399.6 44706.8 7414.4 7443.6 7506.3 7606.5 7631.8 29996.6 30940.8 31272.7 31872.7 32060.8 36126.6 37871.8 38173.8 38541.4 39390.2 8852.6 8893.0 8934.7 8942.0 8977.2 8804.9 8964.9 9007.5 9009.0 9278.3 8417.5 8521.7 8622.4 8723.4 8724.3 8258.3 8465.4 8522.2 8538.1 8734.0 8049.4 8259.7 8517.8 8529.9 8537.1 7208.5 7235.2 7387.7 7547.8 7609.3 6965.8 6980.8 7011.3 7108.8 7233.0 09:52:23 INFO - PROCESS | 2967 | -------- Summary: end -------- 09:52:23 INFO - PROCESS | 2967 | 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - PROCESS | 2967 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:23 INFO - TEST-INFO | 2967: exit 0 09:52:24 INFO - TEST-OK | dromaeo_css | took 1114731ms 09:52:24 INFO - TEST-START | kraken 09:52:24 INFO - operating with platform_type : linux_ 09:52:24 INFO - Initialising browser for kraken test... 09:52:24 INFO - TEST-INFO | started process 3298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphmoMsR/profile http://localhost:50756/getInfo.html) 09:52:28 INFO - PROCESS | 3298 | 09:52:28 INFO - PROCESS | 3298 | (process:3367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:52:29 INFO - PROCESS | 3298 | __metrics Screen width/height:1600/1200 09:52:29 INFO - PROCESS | 3298 | colorDepth:24 09:52:29 INFO - PROCESS | 3298 | Browser inner width/height: 1024/697 09:52:29 INFO - PROCESS | 3298 | __metrics 09:52:29 ERROR - PROCESS | 3298 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:29 INFO - PROCESS | 3298 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:52:30 INFO - TEST-INFO | 3298: exit 0 09:52:30 INFO - Browser initialized. 09:52:30 INFO - Running cycle 1/1 for kraken test... 09:52:30 INFO - TEST-INFO | started process 3418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphmoMsR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:32 INFO - PROCESS | 3418 | 09:52:32 INFO - PROCESS | 3418 | (process:3502): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:52:42 INFO - PROCESS | 3418 | RSS: Main: 161472512 09:52:42 INFO - PROCESS | 3418 | 09:52:45 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50756/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:45 INFO - PROCESS | 3418 | RSS: Main: 166961152 09:52:45 INFO - PROCESS | 3418 | 09:52:48 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50756/tests/kraken/driver.html?testName=audio-dft) 09:52:49 INFO - PROCESS | 3418 | RSS: Main: 169177088 09:52:49 INFO - PROCESS | 3418 | 09:52:52 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50756/tests/kraken/driver.html?testName=audio-fft) 09:52:52 INFO - PROCESS | 3418 | RSS: Main: 164909056 09:52:52 INFO - PROCESS | 3418 | 09:52:54 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50756/tests/kraken/driver.html?testName=audio-oscillator) 09:52:55 INFO - PROCESS | 3418 | RSS: Main: 164823040 09:52:55 INFO - PROCESS | 3418 | 09:52:57 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:58 INFO - PROCESS | 3418 | RSS: Main: 163475456 09:52:58 INFO - PROCESS | 3418 | 09:53:01 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50756/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:02 INFO - PROCESS | 3418 | RSS: Main: 165367808 09:53:02 INFO - PROCESS | 3418 | 09:53:05 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50756/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:06 INFO - PROCESS | 3418 | RSS: Main: 164900864 09:53:06 INFO - PROCESS | 3418 | 09:53:09 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50756/tests/kraken/driver.html?testName=json-parse-financial) 09:53:09 INFO - PROCESS | 3418 | RSS: Main: 165502976 09:53:09 INFO - PROCESS | 3418 | 09:53:11 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:12 INFO - PROCESS | 3418 | RSS: Main: 165441536 09:53:12 INFO - PROCESS | 3418 | 09:53:14 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:14 INFO - PROCESS | 3418 | RSS: Main: 166166528 09:53:14 INFO - PROCESS | 3418 | 09:53:16 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:17 INFO - PROCESS | 3418 | RSS: Main: 166879232 09:53:17 INFO - PROCESS | 3418 | 09:53:20 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:20 INFO - PROCESS | 3418 | RSS: Main: 165040128 09:53:20 INFO - PROCESS | 3418 | 09:53:23 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:23 INFO - PROCESS | 3418 | RSS: Main: 166449152 09:53:23 INFO - PROCESS | 3418 | 09:53:25 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:50756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50756/tests/kraken/driver.html?testName=ai-astar) 09:53:26 INFO - PROCESS | 3418 | RSS: Main: 166998016 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | __start_tp_report 09:53:26 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 09:53:26 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 09:53:26 INFO - PROCESS | 3418 | |i|pagename|runs| 09:53:26 INFO - PROCESS | 3418 | |0;ai-astar;115;111;115;118;116;129;115;114;116;114 09:53:26 INFO - PROCESS | 3418 | |1;audio-beat-detection;155;135;160;171;136;164;165;135;186;138 09:53:26 INFO - PROCESS | 3418 | |2;audio-dft;163;164;164;162;165;176;162;164;167;164 09:53:26 INFO - PROCESS | 3418 | |3;audio-fft;73;77;73;73;74;137;73;74;74;75 09:53:26 INFO - PROCESS | 3418 | |4;audio-oscillator;96;95;137;95;95;95;140;94;95;141 09:53:26 INFO - PROCESS | 3418 | |5;imaging-gaussian-blur;117;118;118;118;118;118;119;118;118;118 09:53:26 INFO - PROCESS | 3418 | |6;imaging-darkroom;148;149;148;149;147;147;148;147;148;147 09:53:26 INFO - PROCESS | 3418 | |7;imaging-desaturate;96;96;97;96;96;96;97;97;97;96 09:53:26 INFO - PROCESS | 3418 | |8;json-parse-financial;68;69;68;68;69;67;69;74;66;66 09:53:26 INFO - PROCESS | 3418 | |9;json-stringify-tinderbox;71;71;74;71;70;71;71;75;70;71 09:53:26 INFO - PROCESS | 3418 | |10;stanford-crypto-aes;85;93;84;93;86;86;85;92;93;86 09:53:26 INFO - PROCESS | 3418 | |11;stanford-crypto-ccm;123;120;131;132;125;135;123;140;131;120 09:53:26 INFO - PROCESS | 3418 | |12;stanford-crypto-pbkdf2;143;153;152;152;149;142;160;152;154;143 09:53:26 INFO - PROCESS | 3418 | |13;stanford-crypto-sha256-iterative;73;74;71;73;73;71;70;72;70;72 09:53:26 INFO - PROCESS | 3418 | __end_tp_report 09:53:26 INFO - PROCESS | 3418 | __start_cc_report 09:53:26 INFO - PROCESS | 3418 | _x_x_mozilla_cycle_collect,873 09:53:26 INFO - PROCESS | 3418 | __end_cc_report 09:53:26 INFO - PROCESS | 3418 | __startTimestamp1457027606022__endTimestamp 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | ------- Summary: start ------- 09:53:26 INFO - PROCESS | 3418 | Number of tests: 14 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.50 stddev:4.81 (4.2%) stddev-sans-first:5.08 09:53:26 INFO - PROCESS | 3418 | Values: 115.0 111.0 115.0 118.0 116.0 129.0 115.0 114.0 116.0 114.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:162.00 stddev:17.86 (11.0%) stddev-sans-first:18.94 09:53:26 INFO - PROCESS | 3418 | Values: 155.0 135.0 160.0 171.0 136.0 164.0 165.0 135.0 186.0 138.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.09 (2.5%) stddev-sans-first:4.27 09:53:26 INFO - PROCESS | 3418 | Values: 163.0 164.0 164.0 162.0 165.0 176.0 162.0 164.0 167.0 164.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:19.96 (27.0%) stddev-sans-first:21.00 09:53:26 INFO - PROCESS | 3418 | Values: 73.0 77.0 73.0 73.0 74.0 137.0 73.0 74.0 74.0 75.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.44 (22.6%) stddev-sans-first:22.28 09:53:26 INFO - PROCESS | 3418 | Values: 96.0 95.0 137.0 95.0 95.0 95.0 140.0 94.0 95.0 141.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 09:53:26 INFO - PROCESS | 3418 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:53:26 INFO - PROCESS | 3418 | Values: 148.0 149.0 148.0 149.0 147.0 147.0 148.0 147.0 148.0 147.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:53:26 INFO - PROCESS | 3418 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:68.50 stddev:2.27 (3.3%) stddev-sans-first:2.40 09:53:26 INFO - PROCESS | 3418 | Values: 68.0 69.0 68.0 68.0 69.0 67.0 69.0 74.0 66.0 66.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:1.65 (2.3%) stddev-sans-first:1.74 09:53:26 INFO - PROCESS | 3418 | Values: 71.0 71.0 74.0 71.0 70.0 71.0 71.0 75.0 70.0 71.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:3.89 (4.4%) stddev-sans-first:3.94 09:53:26 INFO - PROCESS | 3418 | Values: 85.0 93.0 84.0 93.0 86.0 86.0 85.0 92.0 93.0 86.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:131.00 stddev:6.78 (5.2%) stddev-sans-first:6.95 09:53:26 INFO - PROCESS | 3418 | Values: 123.0 120.0 131.0 132.0 125.0 135.0 123.0 140.0 131.0 120.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:152.00 stddev:5.77 (3.8%) stddev-sans-first:5.54 09:53:26 INFO - PROCESS | 3418 | Values: 143.0 153.0 152.0 152.0 149.0 142.0 160.0 152.0 154.0 143.0 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.50 stddev:1.37 (1.9%) stddev-sans-first:1.39 09:53:26 INFO - PROCESS | 3418 | Values: 73.0 74.0 71.0 73.0 73.0 71.0 70.0 72.0 70.0 72.0 09:53:26 INFO - PROCESS | 3418 | -------- Summary: end -------- 09:53:26 INFO - PROCESS | 3418 | 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:26 INFO - PROCESS | 3418 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:53:27 INFO - TEST-INFO | 3418: exit 0 09:53:27 INFO - TEST-OK | kraken | took 63072ms 09:53:27 INFO - SUITE-END | took 1177s 09:53:27 INFO - Completed test suite (00:19:37) 09:53:27 INFO - Working with test: dromaeo_css 09:53:27 INFO - Generating results file: dromaeo_css 09:53:27 INFO - Working with test: kraken 09:53:27 INFO - Generating results file: kraken 09:53:27 INFO - javascript benchmark 09:53:27 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:53:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 09:53:27 INFO - process_Request line: dromaeo_css 5871.54 graph.html#tests=[[72,94,43]] 09:53:27 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:53:27 INFO - process_Request line: kraken 1564.80 graph.html#tests=[[232,94,43]] 09:53:27 INFO - RETURN: dromaeo_css: 5871.54 09:53:27 INFO - RETURN: kraken: 1564.80 09:53:27 INFO - javascript benchmark 09:53:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2648.854313012784, 2679.9196024119283, 2705.2154875086226, 2714.837109773414, 2728.16790878782, 4444.733316001042, 4545.295479200725, 4559.270516717322, 4592.954070459295, 4594.7013444126105, 4558.589726924576, 4562.726236425817, 4578.31325301205, 4588.81644734211, 4636.397268355117, 4191.224623444665, 4227.978860105695, 4230.576942305775, 4369.606735393814, 4374.584414480635, 4135.421041054255, 4181.770002649853, 4306.267934451135, 4325.826966921335, 4336.436263285768, 4194.056337324108, 4204.894877628053, 4219.578042195786, 4221.409002739619, 4225.894352641178, 4165.91668166638, 4215.072684009513, 4227.471566054243, 4238.406623072772, 4253.744775313491, 4079.4900637420324, 4187.2044311581, 4213.620774130343, 4275.209086319041, 4284.036091879333, 4496.100779844044, 4525.592696657317, 4528.773561321954, 4558.908821823545, 4587.42657167854, 4850.5877000455, 4880.072786170652, 4884.169691152512, 4891.046245981999, 4900.632452566037, 4754.453237877654, 4853.17496025673, 4904.411470623548, 4927.063857866994, 4955.0, 4516.141933032746, 4535.546445355471, 4536.160810250114, 4538.72767633943, 4556.316552517149, 4816.590589799836, 4961.131801934647, 4983.352164218629, 4992.875178120504, 5013.724245166551, 4746.525347465225, 4772.260299653559, 4773.284007398918, 4816.446108697544, 4831.879203019882, 4779.4264688236935, 4878.268259760993, 4901.828436004723, 4909.582685471703, 4965.428975667773, 4637.420322459692, 4802.8799280018275, 4814.422269327633, 4817.9036419271415, 4882.194437917704, 4787.3776409066595, 4824.131656301829, 4851.975740121276, 4864.489228631013, 4885.926711099336, 4022.255882661717, 4051.594840515984, 4055.1889622075114, 4083.4895638045246, 4092.7339722917914, 3454.844531996066, 3532.717382609385, 3538.982305088458, 3557.1107223194203, 3611.8194090295906, 4237.766922819213, 4238.258304796648, 4251.681123915719, 4265.722728022669, 4283.828646854154, 4885.022995400934, 4885.462599114095, 4899.632527560448, 4902.975485122552, 4953.083679519301, 4164.12553363797, 4232.047789247456, 4254.553271906467, 4257.467816522934, 4265.957340426618, 4342.544032876565, 4356.3683265926265, 4357.520672725997, 4363.672724545671, 4402.3836662867225, 4621.7920193592045, 4623.630109591225, 4670.8365207217585, 4674.415698037746, 4703.905921881612, 4842.975785121052, 4879.707217566957, 4890.24201248807, 4891.315215869852, 4920.163572192808, 4635.188841952578, 4652.0, 4680.157571637002, 4682.1806183917, 4721.102990431807, 4704.435467743892, 4844.515548445268, 4869.70781753096, 4876.634252431011, 4904.337914381513, 4711.764411779466, 4804.3273941648895, 4819.6867203631655, 4829.082474329866, 4829.9275510868065, 4724.433068031721, 4745.145873742759, 4752.2158843790385, 4756.072565849626, 4764.976175119103, 4753.928691069567, 4763.095011947719, 4763.618910487222, 4767.904641907212, 4796.20862557688, 4500.9099818004115, 4625.676202665781, 4630.6758526902795, 4670.416197975253, 4675.064987002545, 4759.23852183649, 4768.880777980439, 4779.665423420466, 4781.976090119666, 4837.806487740451, 4578.084383123455, 4658.138244424792, 4661.324108004388, 4667.9766601166775, 4705.176594096088], "unit": "score", "name": "dojo.html", "value": 4485.126890160826}, {"lowerIsBetter": false, "replicates": [467.50911542879976, 477.42231899401725, 493.94319653239876, 498.7954938475224, 530.928324676169, 30748.0, 30994.845025774895, 31094.067177984667, 31243.84378078112, 31308.843455782717, 34340.313193736176, 35339.11652208689, 35345.2930941381, 35487.4676879847, 35500.2899942001, 7260.818479538014, 7428.925710742905, 7432.145303290136, 7449.143348514936, 7454.291842274975, 7436.516626419266, 7495.812604684872, 7565.546067235983, 7595.202503737111, 7626.122995855492, 7532.698692052311, 7536.171021187665, 7547.924520754805, 7599.848003039936, 7619.276168763986, 7364.742234021837, 7411.221821708697, 7415.110186777594, 7425.777226683181, 7507.962460187691, 7485.476016678835, 7654.043244594426, 7675.19410461899, 7720.459567830254, 7727.574983375912, 32397.51403728946, 32452.675473245203, 32645.0, 32680.673193268, 32806.83596582025, 2624.134035768192, 2696.7438093381097, 2719.252205643444, 2724.2916841621322, 3187.2589373810174, 26452.8677356612, 26521.336966575796, 26543.336416589547, 26681.46637067248, 27581.31046723828, 3261.575995120619, 3275.279438523521, 3293.4071867063917, 3298.2743796365003, 3360.9495857562156, 208655.0, 210285.0, 210446.0, 211277.0, 211925.99999999846, 36167.63832361696, 47791.522084779404, 48113.278300825514, 48405.27392089122, 48454.27318590224, 34464.82767586196, 34494.31011379758, 34589.82705086459, 34629.82685086609, 34948.47577286343, 12342.074344424203, 12514.49942002328, 12527.624171274876, 12567.18313309632, 12607.873921260854, 9171.128742769426, 9188.770280742901, 9233.399829011092, 9237.815243695088, 9238.86141707875, 11931.940340298417, 11979.52081916731, 12378.133530652947, 12446.937765311297, 12544.623661290176, 4999.950000500021, 5022.547970682656, 5079.619028572872, 5121.308623335876, 5151.407588127338, 749.7375918428506, 790.7351037402419, 805.8630032894422, 807.6204184033495, 837.5895811052541, 24520.754792452204, 24778.0, 24981.0, 25285.620715689278, 25551.61672574913, 826.7271800306005, 907.2061945797427, 939.5490164720973, 966.1787480641399, 1025.1132770153763, 12858.292793896238, 13290.3354832258, 13495.527656531975, 13517.459301627825, 13559.186448813103, 258417.0, 260754.0, 261182.0, 263059.0, 265171.0, 41497.1700565987, 42022.78988605038, 42183.578164218576, 42214.788926055175, 42290.51983180574, 967.2407160379069, 1017.2472370445817, 1041.2867185977477, 1093.5188517052472, 1094.8631421072366, 24283.51432971366, 24815.0, 25452.363690907874, 25763.6135457972, 25859.577723225404, 37031.814840925625, 37371.25257494889, 37478.62521374752, 37522.8123859379, 37687.0, 246176.0, 246966.0, 247979.0, 248010.0, 248314.0, 27873.655161379953, 28073.0, 28371.148865534065, 28374.716252837206, 28765.424691506472, 36567.26865462729, 36664.45003324899, 36956.076098097765, 37102.44346334861, 37296.81351593225, 26521.469570608093, 26819.597706034816, 27179.320516987234, 27418.17745467639, 28184.29539261535, 31569.0, 31666.0, 31687.841560792047, 31948.0, 32091.839540802146, 31670.366592668477, 31680.841595791873, 31895.840520797246, 35165.47251791276, 36098.0, 31100.68899310978, 33639.0, 34063.4890476648, 34186.31627367389, 34239.48640770341, 27254.318642034108, 27585.86207068952, 27942.3014424641, 28136.0, 28175.295617609725], "unit": "score", "name": "ext.html", "value": 15320.890546244864}, {"lowerIsBetter": false, "replicates": [303.5310445361916, 306.7990466244611, 311.4363002964634, 316.18897527841085, 317.85855294394, 11158.0, 14570.635734106652, 14937.775933360994, 15000.399984000627, 15095.92452037741, 13397.062205645609, 13656.112352697093, 13677.110987785813, 13712.58862234132, 13947.860521394783, 4719.0, 4970.900581988358, 4971.130052240844, 4982.975085124569, 4988.875278118058, 4722.1028004679, 4873.415190177166, 4879.731614761186, 4919.60643148549, 4955.0089982003565, 4841.6852904561265, 4887.584555312803, 4890.3642526471685, 4894.216925291954, 4898.191798353268, 4959.628027897904, 5716.771329146829, 5730.140478928173, 5739.540836733093, 5742.598018138732, 5021.07110184617, 5036.420811606676, 5055.266986286968, 5060.165072762989, 5085.821996230151, 11018.11855051594, 11280.774384512346, 11285.379304138269, 11314.0, 11339.37633430161, 1785.7053586158397, 1826.7899191593003, 1843.7142242952364, 1844.6402951424477, 1871.6724573199635, 8750.868736968887, 8758.0, 9333.346665733401, 9717.0, 11319.094472442184, 1681.941132060372, 1700.6173610937565, 1734.4363081998401, 1771.6899542579997, 1796.4341232511717, 52173.73913130448, 55263.0, 55888.0, 56039.0, 57075.0, 9451.905480945103, 9467.337286389886, 9499.572519236652, 9630.181434578139, 9682.031796820402, 11994.400279985966, 12024.398780060961, 12059.397030148457, 12100.213486123374, 12101.273923564439, 6322.0, 6530.869382612321, 6621.437177839841, 6646.26891041985, 6662.367075127855, 6169.136320915076, 6239.719212635442, 6317.96841015792, 6355.904661430082, 6405.647689377036, 3712.7586706863967, 3810.994594863864, 3872.3223435898603, 3878.5733569307354, 4117.032497363117, 1640.7374820028738, 1656.3209084275388, 1702.829717028312, 1741.8171092035154, 1742.599202183505, 791.2245998921089, 811.5942028985507, 852.4033176776281, 870.8563087090686, 929.7210836748948, 14560.199189044704, 14782.704345913022, 14796.926015369854, 15142.470013549473, 15307.15810630426, 784.3607459920147, 790.4822341366414, 797.143071198464, 845.7166849105496, 846.7205822078822, 8473.322134229247, 8508.489490630458, 8587.270082043096, 8644.740657780276, 8656.783580410414, 361032.0, 361174.0, 362826.0, 363067.0, 370763.0, 59255.70372148198, 60341.0, 61055.69472152611, 62306.37693623006, 62663.0, 813.7477382011477, 817.7546735979302, 829.2371018662844, 836.8786525953702, 844.438448431786, 13567.932160339134, 13662.248576328, 13794.103383280055, 13838.100523465942, 14070.155790652594, 29286.0, 29750.404991900472, 30396.696033039385, 30976.380472390876, 31279.37441251208, 39875.40186897141, 41360.58639413567, 42362.788186058875, 42629.0, 42678.57321426746, 6670.332966703291, 6734.427573656294, 6952.200496942714, 7114.964425177841, 7156.499045066796, 9750.171235445066, 10066.245031622511, 10135.949320253352, 10574.10120139766, 10726.0, 9399.718008459757, 9400.764980875532, 9474.336796424184, 9497.67307009787, 9512.714618561178, 9059.592318345822, 9190.126937940884, 9195.264378849542, 9287.0, 9312.627494900127, 8778.561071946506, 8938.37431379797, 9116.316276279438, 9386.76533086651, 9872.555734992085, 6899.965500172668, 7019.6490175492045, 7033.613151276524, 7141.9642901785155, 7268.454865885185, 7657.617119143909, 8909.73270801877, 9522.95238523803, 9554.0, 9957.0], "unit": "score", "name": "jquery.html", "value": 7307.120446186019}, {"lowerIsBetter": false, "replicates": [1118.7426891814885, 1120.8991190792826, 1121.7251773315538, 1254.6737848159476, 1312.6455856918637, 5963.0, 6633.502487313447, 6855.485838562103, 6982.650867456619, 7008.439324854012, 6807.863842723143, 6862.897056544143, 6863.725450981955, 6870.07254020707, 6963.094797676307, 1969.9310524131695, 1991.4224874786294, 1994.0627904884755, 1997.0314397517266, 1998.580298137393, 1869.7849747279033, 1923.0384807596201, 1925.0855843474378, 1929.0354822588706, 1938.2150229157214, 1926.9325573604926, 1966.1250743419184, 1970.5369238229005, 1975.693767466045, 1977.4561995451222, 2024.8380129589598, 2043.9693404598943, 2045.1308194017483, 2050.3643870400224, 2063.1025503905776, 1961.264525802824, 1963.136220063182, 1974.4175468236904, 2003.6994450832347, 2011.8189362957257, 7068.752593659197, 7071.8939215911805, 7072.045273888062, 7077.71689132434, 7084.504084714072, 3906.570277269498, 4022.577629348935, 4022.9942514371405, 4034.515858097018, 4040.474738284004, 2433.9513209735883, 2459.9016039358403, 2513.082724805433, 2515.559777039011, 2598.974010259892, 775.2092865277442, 782.7495201535511, 809.2231457800518, 824.2869917521301, 838.1241602525375, 9483.715488535356, 9538.14156725891, 9539.90460095397, 9553.952230238805, 9563.808723825554, 3554.1647712787476, 3627.093226693327, 3715.5169827922196, 3722.218334149859, 3724.981375093161, 8121.959390203011, 8178.345732341399, 8186.918130818734, 8204.8359032819, 8210.876836847452, 3943.743656662308, 3953.723239373216, 3960.7623542587535, 3961.603839616015, 3964.0486283291802, 3060.5103183490533, 3454.894433781166, 3538.911527211789, 3542.415501442233, 3549.8580056797437, 3131.6242050953574, 3193.2655489237604, 3218.806871587712, 3220.951685724716, 3233.547303377529, 996.1283876607968, 1022.8312328465869, 1027.8406846938738, 1028.28534168752, 1037.0977249792577, 784.2314531758794, 798.4331124901269, 804.0994086623019, 903.1014140929817, 988.8665030220972, 6130.356312587114, 6140.907886381708, 6151.169592105098, 6162.845928851814, 6203.286622038523, 397.34438177008167, 398.8484375937125, 1025.3540269630234, 1061.4374381577777, 1073.2594509788378, 4799.088173247072, 4827.927581086286, 4931.778069986859, 4956.35567376246, 5011.824586139468, 7896.447248692536, 8126.187381261827, 8143.470674406263, 8165.428420010542, 8171.264586187272, 7879.33025692811, 7942.483738557091, 8042.638081286356, 8047.919520804717, 8051.074126475413, 6479.157709497829, 6531.0856480092825, 6588.86822263552, 6629.403353698191, 6632.204135503771, 6161.938380616316, 6168.383161683796, 6178.567500275118, 6206.06908963659, 6222.346653601307, 7057.0, 7224.313690199423, 7252.927470725436, 7386.852262954603, 7441.55350678961, 7381.483296169216, 7437.144728356308, 7510.586917719578, 7527.736529221451, 7540.434467414856, 5799.623024503394, 5815.79644712433, 5848.2689663792025, 5868.735906884115, 5961.791337303347, 6370.968145159244, 6390.009548519801, 6398.776042838478, 6441.903371449525, 6457.903131452938, 5640.802571909963, 5800.1299805029585, 5851.063829787214, 5866.794662186803, 6007.4893634039845, 5704.372519022987, 5839.328477225174, 5928.822135335947, 5940.0, 5992.550558708202, 6003.459688628044, 6057.666828324484, 6059.0, 6090.969545152246, 6119.908201377072, 5809.593328466966, 5829.329627092939, 5849.181114644039, 5854.0, 5873.236479257669, 5814.970925145347, 5838.153467747238, 5871.853203669943, 5889.823305300848, 5901.380355062656], "unit": "score", "name": "mootools.html", "value": 3825.4341185762396}, {"lowerIsBetter": false, "replicates": [278.27509338174053, 282.6721003635783, 284.7258518131362, 284.75987076282775, 287.2388171345933, 5531.585131115163, 5556.555475561955, 5612.382637909826, 5640.238567793347, 5640.915386269199, 5330.1205301125365, 5513.476219759116, 5521.641093328941, 5528.115501519757, 5533.197686335479, 3985.541662708782, 4128.463299771026, 4135.937960930589, 4139.027328577789, 4165.500139983191, 4084.65280451162, 4104.466419365478, 4118.485189351331, 4129.587041295861, 4136.296829538986, 4071.87784366468, 4075.1458086570537, 4078.8980275493054, 4080.1431699343175, 4082.4080508326424, 4101.794910254505, 4108.609682080198, 4110.815013324393, 4117.114820313647, 4117.649999750025, 3527.382708026111, 3530.8058056806867, 3530.894073177809, 3536.6993805526563, 3540.026492714524, 5294.047071527124, 5297.4437684043005, 5307.973460132714, 5308.309919710451, 5308.362996440414, 4697.107549565571, 4706.011737535087, 4707.199776038047, 4707.952920470786, 4711.4346278446465, 5548.805791797308, 5739.82780516581, 5746.827595172152, 5765.221695071195, 5769.653820770767, 3850.7689538627774, 3851.73037887348, 3854.3447613905705, 3854.3447613905705, 3863.864764733221, 5990.101484777319, 6044.546659000593, 6056.636601803862, 6061.575689701766, 6066.878662426727, 3903.6681882040343, 3913.5108111486065, 3922.2547715933883, 3922.5292964844402, 3935.0162459385156, 3975.1652153048185, 3975.960240397559, 3979.5622481527007, 3986.980065099714, 3991.082051128257, 4609.838655647036, 4620.0, 4620.607248383858, 4655.557722016403, 4665.626749860071, 5517.144842549411, 5763.510101641407, 5791.146833013395, 5800.0429929062075, 5830.854228644318, 1353.3842101843834, 1404.6979899321695, 1409.323524708146, 1410.153907655419, 1416.044170185121, 910.9863352049724, 917.3349321741684, 925.8750068740634, 935.1910597333258, 936.3071327217809, 5043.218301163325, 5047.924281135786, 5049.267856160836, 5052.974735126374, 5063.822766203165, 5942.257217847769, 5971.581989260797, 6020.518358531307, 6025.638461692312, 6055.061465472859, 4985.8005679772405, 5027.547520723152, 5038.395392552917, 5051.722155281494, 5055.418626857959, 3160.225744692565, 3231.2891163943896, 3242.578464799561, 3264.853081611333, 3268.313654132659, 5628.380878103405, 5694.60137790359, 5695.572832037614, 5709.22925405065, 5711.686312148229, 6178.227721534809, 6206.038064100072, 6214.9689251554355, 6218.844528886723, 6227.346128656516, 5685.971570142206, 5705.71471426427, 5720.482987485493, 5725.2843394575675, 5752.453516915886, 5850.356460789395, 5884.904352854963, 6101.877962440815, 6105.542084343603, 6194.225721784777, 5800.854978625568, 5936.28764548257, 5948.73230704628, 5950.494207992196, 5950.553708471795, 5607.102863541813, 5713.314402271754, 5720.74256658443, 5726.742296596746, 5730.111832665943, 3910.7262491625315, 3955.5253369595835, 3961.2869683457257, 3962.187751510991, 3975.0, 6053.697315134314, 6058.90911636317, 6062.575619706578, 6063.848403789941, 6071.0, 5665.858353541194, 5806.216160818404, 5836.358000620014, 5850.356460789395, 5861.648301101947, 5847.26909136358, 5872.471477567039, 5875.794347197828, 5878.794242201502, 5922.644641321534, 5650.406707295675, 5657.32112146545, 5687.260656114679, 5698.2592263005545, 5714.457126572969, 5830.970845145747, 5857.941420585739, 5869.295684517885, 5873.207117039145, 5877.118432235199, 5629.437056294338, 5678.829635110953, 5682.857928551819, 5690.630109043064, 5695.658260504383], "unit": "score", "name": "prototype.html", "value": 4268.340738726641}, {"lowerIsBetter": false, "replicates": [511.1719015195384, 546.1725485888879, 594.658071608825, 595.0716881664603, 599.8860216558853, 10456.372617642937, 10523.0, 10524.579016839318, 10574.471276436187, 10667.733306667336, 9482.857757133648, 9495.24038076954, 9511.857322140157, 9559.044095590454, 9595.66415175469, 643.9098526206335, 658.2298710508717, 661.0843981086182, 662.2251965200727, 663.6482664187988, 652.1098700274139, 656.0814859197114, 659.0575477067791, 661.7816120680164, 662.3078882567728, 680.5916450129932, 685.8525417035337, 689.600031981452, 689.9896501552481, 690.7237105157927, 675.6452862247335, 679.8538314262407, 680.6460640466954, 680.8263892707353, 681.2744427185032, 503.48141414343286, 508.4407152132662, 509.2666560153367, 509.5134146889748, 509.67126203598474, 9182.17360437564, 9214.493202873839, 9229.53852307382, 9289.210417114553, 9296.8605470918, 8904.821903561957, 9009.144131307516, 9102.590383432762, 9255.0, 9479.620815167385, 7700.3069723724575, 7869.488483248628, 7973.641186146638, 7977.202279772035, 8052.758417247492, 3042.3306872488015, 3057.877684892602, 3076.446239676857, 3089.073278016586, 3160.604924384452, 38171.80914095439, 38308.425373619415, 38453.0, 39010.41484377737, 39760.60239397627, 8655.826883462296, 8716.128387161232, 8716.869246961302, 8739.781505462413, 8794.692185773467, 13596.728065438636, 13624.863751362558, 13663.248521331423, 13750.931245343909, 13757.931210344084, 6004.279486461653, 6076.665783381956, 6114.0828875669, 6176.81469555914, 6340.0, 3416.79499230047, 3432.1419645088727, 3454.4300190468794, 3519.859205631797, 3543.706711249139, 2373.655819906104, 2414.167112346238, 2428.3200703802963, 2431.598786200257, 2434.0628857889487, 456.8720758187713, 464.8698364457957, 475.995240047602, 476.4282860567333, 477.8661974647104, 485.9514048595183, 498.3511892696256, 503.67764630636424, 509.7706032285486, 521.4733119549206, 6097.237845269341, 6422.197225346832, 6455.903161452582, 6470.64411457365, 6563.704633291513, 482.74897053531964, 491.46160083170736, 491.8598199513193, 501.83188631808025, 527.1354977836352, 3103.177657920653, 3236.996531075374, 3262.5758651375168, 3279.7048265655726, 3352.782069165545, 46209.30686039712, 47626.0, 48103.0, 48308.5169148311, 48576.5142348579, 41569.0, 42092.0, 42425.57574424278, 42737.786311068245, 43002.56997430048, 37208.0, 42789.786051070165, 43715.78142109269, 44399.55600443954, 44706.77646611811, 7414.406847452299, 7443.590602516913, 7506.3244308012545, 7606.543607383574, 7631.847363052819, 29996.550051749677, 30940.845295773375, 31272.687273126976, 31872.681273186972, 32060.839695801373, 36126.63873361338, 37871.81064094662, 38173.80913095417, 38541.4218786724, 39390.212195756496, 8852.557372131496, 8892.955535222542, 8934.687285944961, 8942.0, 8977.23693486061, 8804.867926980973, 8964.910350896407, 9007.459552426875, 9009.0, 9278.304127190622, 8417.494950303002, 8521.701740439055, 8622.439541429787, 8723.432976856484, 8724.258438032584, 8258.339332853477, 8465.407421480684, 8522.23299902987, 8538.14618538166, 8734.0, 8049.356051515982, 8259.669613215405, 8517.829643407222, 8529.914700852913, 8537.103604121477, 7208.531445456028, 7235.2402997684485, 7387.741429049957, 7547.773566793005, 7609.277118673717, 6965.7561985332295, 6980.7905762827195, 7011.26381729911, 7108.751193708195, 7233.0], "unit": "score", "name": "yui.html", "value": 4997.198035759115}], "name": "dromaeo_css", "value": 5871.545005721451}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 115.0, 118.0, 116.0, 129.0, 115.0, 114.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 160.0, 171.0, 136.0, 164.0, 165.0, 135.0, 186.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 154.5}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 164.0, 162.0, 165.0, 176.0, 162.0, 164.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 73.0, 73.0, 74.0, 137.0, 73.0, 74.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 137.0, 95.0, 95.0, 95.0, 140.0, 94.0, 95.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.0}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 67.0, 69.0, 74.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 74.0, 71.0, 70.0, 71.0, 71.0, 75.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.5}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 84.0, 93.0, 86.0, 86.0, 85.0, 92.0, 93.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [123.0, 120.0, 131.0, 132.0, 125.0, 135.0, 123.0, 140.0, 131.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.0}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 152.0, 152.0, 149.0, 142.0, 160.0, 152.0, 154.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 71.0, 73.0, 73.0, 71.0, 70.0, 72.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1564.8}]} 09:53:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1564.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "5871.54"}}} 09:53:27 INFO - Return code: 0 09:53:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:53:27 ERROR - # TBPL SUCCESS # 09:53:27 INFO - Running post-action listener: _resource_record_post_action 09:53:27 INFO - Running post-run listener: _resource_record_post_run 09:53:28 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 526016512; Read time: 0; Write time: 479676 09:53:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233603072; Read time: 0; Write time: 212012 09:53:28 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 292122624; Read time: 0; Write time: 267664 09:53:28 INFO - Running post-run listener: _upload_blobber_files 09:53:28 INFO - Blob upload gear active. 09:53:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:28 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 09:53:28 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:28 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:29 INFO - (blobuploader) - INFO - Done attempting. 09:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:30 INFO - (blobuploader) - INFO - Done attempting. 09:53:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:30 INFO - Return code: 0 09:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae409b765ffafe21250a3eae2a8f991fac7548dfbd888f65f1663d73e13f5d29ee13c297a174268a9e9c101cdae3162727a58be5bc18b1b420272d823bbfa401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378356bf534bc87adbb5d5293b278b8312ffa172e977fb090fdbdad88e1a914ef0ce89489671dd5a0235f34402fd32c596436df2fe1d274b7608990a598c1344"} 09:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:30 INFO - Contents: 09:53:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae409b765ffafe21250a3eae2a8f991fac7548dfbd888f65f1663d73e13f5d29ee13c297a174268a9e9c101cdae3162727a58be5bc18b1b420272d823bbfa401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378356bf534bc87adbb5d5293b278b8312ffa172e977fb090fdbdad88e1a914ef0ce89489671dd5a0235f34402fd32c596436df2fe1d274b7608990a598c1344"} 09:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:30 INFO - Copying logs to upload dir... 09:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.174882 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-03 09:53:29.192343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 09:53:29.196002) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 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/Firefox-Non-PGO/sha512/ae409b765ffafe21250a3eae2a8f991fac7548dfbd888f65f1663d73e13f5d29ee13c297a174268a9e9c101cdae3162727a58be5bc18b1b420272d823bbfa401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378356bf534bc87adbb5d5293b278b8312ffa172e977fb090fdbdad88e1a914ef0ce89489671dd5a0235f34402fd32c596436df2fe1d274b7608990a598c1344"} build_url:https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/cGaGyDomTwe8K1HjGs4wGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae409b765ffafe21250a3eae2a8f991fac7548dfbd888f65f1663d73e13f5d29ee13c297a174268a9e9c101cdae3162727a58be5bc18b1b420272d823bbfa401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/378356bf534bc87adbb5d5293b278b8312ffa172e977fb090fdbdad88e1a914ef0ce89489671dd5a0235f34402fd32c596436df2fe1d274b7608990a598c1344"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 09:53:29.226618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:53:29.226993) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1457026374.870871-1820719552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 09:53:29.309623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:53:29.309972) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:53:29.310317) ========= ========= Total master_lag: 0.28 =========