builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1459833213.25 results: success (0) buildid: 20160404203620 builduid: c9dddf275bad433599905d88e7d65b1b revision: fd37367d1b1f2952c7a970c4b41e650d7233c717 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.247906) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.248886) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.249533) ========= 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005220 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.270059) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.270446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.278873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.279300) ========= 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003277 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.330494) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.331233) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.332000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.332331) ========= 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 22:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.4M=0s 2016-04-04 22:13:34 (67.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.528263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.528702) ========= 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013933 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.579445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:33.579924) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd37367d1b1f2952c7a970c4b41e650d7233c717 --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 fd37367d1b1f2952c7a970c4b41e650d7233c717 --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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 22:13:34,205 truncating revision to first 12 chars 2016-04-04 22:13:34,206 Setting DEBUG logging. 2016-04-04 22:13:34,206 attempt 1/10 2016-04-04 22:13:34,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd37367d1b1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 22:13:34,465 unpacking tar archive at: mozilla-central-fd37367d1b1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:34.145151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:34.146006) ========= echo fd37367d1b1f2952c7a970c4b41e650d7233c717 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fd37367d1b1f2952c7a970c4b41e650d7233c717'] 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fd37367d1b1f2952c7a970c4b41e650d7233c717 program finished with exit code 0 elapsedTime=0.004879 script_repo_revision: 'fd37367d1b1f2952c7a970c4b41e650d7233c717' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:34.202767) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:34.203516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:13:34.214591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-04 22:13:34.215332) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:13:34 INFO - MultiFileLogger online at 20160404 22:13:34 in /builds/slave/test 22:13:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 22:13:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:13:34 INFO - {'append_to_log': False, 22:13:34 INFO - 'base_work_dir': '/builds/slave/test', 22:13:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:13:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:13:34 INFO - 'branch': 'Firefox-Non-PGO', 22:13:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:13:34 INFO - 'config_files': ('talos/linux_config.py',), 22:13:34 INFO - 'default_actions': ('clobber', 22:13:34 INFO - 'read-buildbot-config', 22:13:34 INFO - 'download-and-extract', 22:13:34 INFO - 'populate-webroot', 22:13:34 INFO - 'create-virtualenv', 22:13:34 INFO - 'install', 22:13:34 INFO - 'run-tests'), 22:13:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:13:34 INFO - 'download_minidump_stackwalk': True, 22:13:34 INFO - 'download_symbols': 'ondemand', 22:13:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:13:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:13:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:13:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:13:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:13:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:13:34 INFO - 'installer_path': 'installer.exe', 22:13:34 INFO - 'log_level': 'info', 22:13:34 INFO - 'log_name': 'talos', 22:13:34 INFO - 'log_to_console': True, 22:13:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:13:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:13:34 INFO - 'opt_config_files': (), 22:13:34 INFO - 'pip_index': False, 22:13:34 INFO - 'sps_profile': False, 22:13:34 INFO - 'sps_profile_interval': 0, 22:13:34 INFO - 'suite': 'dromaeojs', 22:13:34 INFO - 'system_bits': '32', 22:13:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:13:34 INFO - 'title': 'talos-linux64-ix-028', 22:13:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:13:34 INFO - 'use_talos_json': True, 22:13:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:13:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:13:34 INFO - 'work_dir': 'build'} 22:13:34 INFO - ##### 22:13:34 INFO - ##### Running clobber step. 22:13:34 INFO - ##### 22:13:34 INFO - Running pre-action listener: _resource_record_pre_action 22:13:34 INFO - Running main action method: clobber 22:13:34 INFO - rmtree: /builds/slave/test/build 22:13:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:13:35 INFO - Running post-action listener: _resource_record_post_action 22:13:35 INFO - ##### 22:13:35 INFO - ##### Running read-buildbot-config step. 22:13:35 INFO - ##### 22:13:35 INFO - Running pre-action listener: _resource_record_pre_action 22:13:35 INFO - Running main action method: read_buildbot_config 22:13:35 INFO - Using buildbot properties: 22:13:35 INFO - { 22:13:35 INFO - "project": "", 22:13:35 INFO - "product": "firefox", 22:13:35 INFO - "script_repo_revision": "production", 22:13:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:13:35 INFO - "repository": "", 22:13:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:13:35 INFO - "buildid": "20160404203620", 22:13:35 INFO - "pgo_build": "False", 22:13:35 INFO - "basedir": "/builds/slave/test", 22:13:35 INFO - "buildnumber": 538, 22:13:35 INFO - "slavename": "talos-linux64-ix-028", 22:13:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:13:35 INFO - "platform": "ubuntu64_hw", 22:13:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:13:35 INFO - "branch": "mozilla-central", 22:13:35 INFO - "repo_path": "mozilla-central", 22:13:35 INFO - "revision": "fd37367d1b1f2952c7a970c4b41e650d7233c717", 22:13:35 INFO - "stage_platform": "linux64", 22:13:35 INFO - "builduid": "c9dddf275bad433599905d88e7d65b1b", 22:13:35 INFO - "slavebuilddir": "test" 22:13:35 INFO - } 22:13:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:13:35 INFO - Running post-action listener: _resource_record_post_action 22:13:35 INFO - ##### 22:13:35 INFO - ##### Running download-and-extract step. 22:13:35 INFO - ##### 22:13:35 INFO - Running pre-action listener: _resource_record_pre_action 22:13:35 INFO - Running main action method: download_and_extract 22:13:35 INFO - mkdir: /builds/slave/test/build/tests 22:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:35 INFO - https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:13:36 INFO - Downloaded 1361 bytes. 22:13:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:13:36 INFO - Using the following test package requirements: 22:13:36 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:13:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:13:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'jsshell-linux-x86_64.zip'], 22:13:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:13:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:13:36 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:13:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:13:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:36 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:13:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:36 INFO - https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:37 INFO - Downloaded 22125242 bytes. 22:13:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:38 INFO - Return code: 0 22:13:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:38 INFO - https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:39 INFO - Downloaded 22125242 bytes. 22:13:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:40 INFO - Return code: 0 22:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:40 INFO - https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:13:41 INFO - Downloaded 10847584 bytes. 22:13:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:13:41 INFO - Return code: 0 22:13:41 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')]} 22:13:41 INFO - https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:13:43 INFO - Downloaded 54091567 bytes. 22:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:13:43 INFO - mkdir: /builds/slave/test/properties 22:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:43 INFO - Contents: 22:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:13:44 INFO - Running post-action listener: _resource_record_post_action 22:13:44 INFO - Running post-action listener: set_extra_try_arguments 22:13:44 INFO - ##### 22:13:44 INFO - ##### Running populate-webroot step. 22:13:44 INFO - ##### 22:13:44 INFO - Running pre-action listener: _resource_record_pre_action 22:13:44 INFO - Running main action method: populate_webroot 22:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:44 INFO - '--tppagecycles', 22:13:44 INFO - '7'], 22:13:44 INFO - 'tests': ['tsvgm']}}, 22:13:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:13:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:13:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'tests': ['damp', 'tps']}, 22:13:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['damp', 'tps']}, 22:13:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:13:44 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['dromaeo_dom']}, 22:13:44 INFO - 'other': {'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other_l64': {'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:13:44 INFO - 'ts_paint', 22:13:44 INFO - 'tpaint', 22:13:44 INFO - 'sessionrestore', 22:13:44 INFO - 'sessionrestore_no_auto_restore', 22:13:44 INFO - 'tabpaint']}, 22:13:44 INFO - 'svgr': {'tests': ['tsvgx', 22:13:44 INFO - 'tsvgr_opacity', 22:13:44 INFO - 'tart', 22:13:44 INFO - 'tscrollx', 22:13:44 INFO - 'cart']}, 22:13:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['tsvgx', 22:13:44 INFO - 'tsvgr_opacity', 22:13:44 INFO - 'tart', 22:13:44 INFO - 'tscrollx', 22:13:44 INFO - 'cart']}, 22:13:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'tests': ['tp5o']}, 22:13:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--e10s'], 22:13:44 INFO - 'tests': ['tp5o']}, 22:13:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--xperf_path', 22:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:44 INFO - 'tests': ['tp5n']}, 22:13:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:44 INFO - 'talos_options': ['--e10s', 22:13:44 INFO - '--xperf_path', 22:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:44 INFO - 'tests': ['tp5n']}}, 22:13:44 INFO - 'talos.zip': {'path': '', 22:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:44 INFO - Running post-action listener: _resource_record_post_action 22:13:44 INFO - ##### 22:13:44 INFO - ##### Running create-virtualenv step. 22:13:44 INFO - ##### 22:13:44 INFO - Running pre-action listener: _resource_record_pre_action 22:13:44 INFO - Running main action method: create_virtualenv 22:13:44 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:44 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 22:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:44 INFO - Using real prefix '/usr' 22:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:46 INFO - Installing pip.................done. 22:13:46 INFO - Return code: 0 22:13:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13:46 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')]} 22:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:46 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')]} 22:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:46 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 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:13:46 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 22:13:46 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 22:13:46 INFO - Using env: {'DISPLAY': ':0', 22:13:46 INFO - 'HOME': '/home/cltbld', 22:13:46 INFO - 'LANG': 'en_US.UTF-8', 22:13:46 INFO - 'LANGUAGE': 'en_US:en', 22:13:46 INFO - 'LOGNAME': 'cltbld', 22:13:46 INFO - 'MAIL': '/var/mail/cltbld', 22:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:46 INFO - 'MOZ_NO_REMOTE': '1', 22:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:46 INFO - 'NO_EM_RESTART': '1', 22:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:46 INFO - 'PWD': '/builds/slave/test', 22:13:46 INFO - 'SHELL': '/bin/bash', 22:13:46 INFO - 'SHLVL': '1', 22:13:46 INFO - 'TERM': 'linux', 22:13:46 INFO - 'TMOUT': '86400', 22:13:46 INFO - 'USER': 'cltbld', 22:13:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:46 INFO - '_': '/tools/buildbot/bin/python'} 22:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:46 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 22:13:46 INFO - Cleaning up... 22:13:46 INFO - Return code: 0 22:13:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:13:46 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')]} 22:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:46 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')]} 22:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:46 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 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:13:46 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 22:13:46 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 22:13:46 INFO - Using env: {'DISPLAY': ':0', 22:13:46 INFO - 'HOME': '/home/cltbld', 22:13:46 INFO - 'LANG': 'en_US.UTF-8', 22:13:46 INFO - 'LANGUAGE': 'en_US:en', 22:13:46 INFO - 'LOGNAME': 'cltbld', 22:13:46 INFO - 'MAIL': '/var/mail/cltbld', 22:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:46 INFO - 'MOZ_NO_REMOTE': '1', 22:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:46 INFO - 'NO_EM_RESTART': '1', 22:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:46 INFO - 'PWD': '/builds/slave/test', 22:13:46 INFO - 'SHELL': '/bin/bash', 22:13:46 INFO - 'SHLVL': '1', 22:13:46 INFO - 'TERM': 'linux', 22:13:46 INFO - 'TMOUT': '86400', 22:13:46 INFO - 'USER': 'cltbld', 22:13:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:46 INFO - '_': '/tools/buildbot/bin/python'} 22:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:47 INFO - Downloading/unpacking psutil>=0.7.1 22:13:47 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 22:13:47 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 22:13:47 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 22:13:47 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 22:13:47 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 22:13:47 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 22:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:49 INFO - Installing collected packages: psutil 22:13:49 INFO - Running setup.py install for psutil 22:13:49 INFO - building 'psutil._psutil_linux' extension 22:13:49 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 22:13:49 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 22:13:49 INFO - building 'psutil._psutil_posix' extension 22:13:49 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 22:13:49 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 22:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:49 INFO - Successfully installed psutil 22:13:49 INFO - Cleaning up... 22:13:49 INFO - Return code: 0 22:13:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:49 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 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:13:49 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 22:13:49 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 22:13:49 INFO - Using env: {'DISPLAY': ':0', 22:13:49 INFO - 'HOME': '/home/cltbld', 22:13:49 INFO - 'LANG': 'en_US.UTF-8', 22:13:49 INFO - 'LANGUAGE': 'en_US:en', 22:13:49 INFO - 'LOGNAME': 'cltbld', 22:13:49 INFO - 'MAIL': '/var/mail/cltbld', 22:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:49 INFO - 'MOZ_NO_REMOTE': '1', 22:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:49 INFO - 'NO_EM_RESTART': '1', 22:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:49 INFO - 'PWD': '/builds/slave/test', 22:13:49 INFO - 'SHELL': '/bin/bash', 22:13:49 INFO - 'SHLVL': '1', 22:13:49 INFO - 'TERM': 'linux', 22:13:49 INFO - 'TMOUT': '86400', 22:13:49 INFO - 'USER': 'cltbld', 22:13:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:49 INFO - '_': '/tools/buildbot/bin/python'} 22:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:13:49 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 22:13:49 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 22:13:49 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 22:13:49 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 22:13:49 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 22:13:49 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 22:13:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:13:51 INFO - Installing collected packages: mozsystemmonitor 22:13:51 INFO - Running setup.py install for mozsystemmonitor 22:13:51 INFO - Successfully installed mozsystemmonitor 22:13:51 INFO - Cleaning up... 22:13:52 INFO - Return code: 0 22:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:52 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')]} 22:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:52 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')]} 22:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:52 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 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:13:52 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 22:13:52 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 22:13:52 INFO - Using env: {'DISPLAY': ':0', 22:13:52 INFO - 'HOME': '/home/cltbld', 22:13:52 INFO - 'LANG': 'en_US.UTF-8', 22:13:52 INFO - 'LANGUAGE': 'en_US:en', 22:13:52 INFO - 'LOGNAME': 'cltbld', 22:13:52 INFO - 'MAIL': '/var/mail/cltbld', 22:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:52 INFO - 'MOZ_NO_REMOTE': '1', 22:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:52 INFO - 'NO_EM_RESTART': '1', 22:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:52 INFO - 'PWD': '/builds/slave/test', 22:13:52 INFO - 'SHELL': '/bin/bash', 22:13:52 INFO - 'SHLVL': '1', 22:13:52 INFO - 'TERM': 'linux', 22:13:52 INFO - 'TMOUT': '86400', 22:13:52 INFO - 'USER': 'cltbld', 22:13:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:52 INFO - '_': '/tools/buildbot/bin/python'} 22:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:52 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 22:13:52 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 22:13:52 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 22:13:52 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 22:13:52 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 22:13:52 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 22:13:55 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:55 INFO - Downloading docopt-0.6.1.tar.gz 22:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:55 INFO - Running setup.py install for blobuploader 22:13:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:55 INFO - Running setup.py install for requests 22:13:56 INFO - Running setup.py install for docopt 22:13:56 INFO - Successfully installed blobuploader requests docopt 22:13:56 INFO - Cleaning up... 22:13:56 INFO - Return code: 0 22:13:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:13:56 INFO - Using env: {'DISPLAY': ':0', 22:13:56 INFO - 'HOME': '/home/cltbld', 22:13:56 INFO - 'LANG': 'en_US.UTF-8', 22:13:56 INFO - 'LANGUAGE': 'en_US:en', 22:13:56 INFO - 'LOGNAME': 'cltbld', 22:13:56 INFO - 'MAIL': '/var/mail/cltbld', 22:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:56 INFO - 'MOZ_NO_REMOTE': '1', 22:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:56 INFO - 'NO_EM_RESTART': '1', 22:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:56 INFO - 'PWD': '/builds/slave/test', 22:13:56 INFO - 'SHELL': '/bin/bash', 22:13:56 INFO - 'SHLVL': '1', 22:13:56 INFO - 'TERM': 'linux', 22:13:56 INFO - 'TMOUT': '86400', 22:13:56 INFO - 'USER': 'cltbld', 22:13:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:56 INFO - '_': '/tools/buildbot/bin/python'} 22:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:56 INFO - Running setup.py (path:/tmp/pip-78vBdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:56 INFO - Running setup.py (path:/tmp/pip-uOpz7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:56 INFO - Running setup.py (path:/tmp/pip-J48U4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:56 INFO - Running setup.py (path:/tmp/pip-D9M26r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:56 INFO - Running setup.py (path:/tmp/pip-qEo0uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:57 INFO - Running setup.py (path:/tmp/pip-1RCj6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:57 INFO - Running setup.py (path:/tmp/pip-s8LxdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:57 INFO - Running setup.py (path:/tmp/pip-aeMwLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:57 INFO - Running setup.py (path:/tmp/pip-3SEGXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:57 INFO - Running setup.py (path:/tmp/pip-_z9MDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:57 INFO - Running setup.py (path:/tmp/pip-uQ2rM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:57 INFO - Running setup.py (path:/tmp/pip-jb_r8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:57 INFO - Running setup.py (path:/tmp/pip-722oZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:57 INFO - Running setup.py (path:/tmp/pip-Gzgn_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:57 INFO - Running setup.py (path:/tmp/pip-6uzeU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:57 INFO - Running setup.py (path:/tmp/pip-bqoaKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:57 INFO - Running setup.py (path:/tmp/pip-MmMMgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:57 INFO - Running setup.py install for manifestparser 22:13:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:57 INFO - Running setup.py install for mozcrash 22:13:58 INFO - Running setup.py install for mozdebug 22:13:58 INFO - Running setup.py install for mozdevice 22:13:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozfile 22:13:58 INFO - Running setup.py install for mozhttpd 22:13:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozinfo 22:13:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozInstall 22:13:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozleak 22:13:58 INFO - Running setup.py install for mozlog 22:13:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for moznetwork 22:13:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:58 INFO - Running setup.py install for mozprocess 22:13:59 INFO - Running setup.py install for mozprofile 22:13:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Running setup.py install for mozrunner 22:13:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Running setup.py install for mozscreenshot 22:13:59 INFO - Running setup.py install for moztest 22:13:59 INFO - Running setup.py install for mozversion 22:13:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:59 INFO - Cleaning up... 22:13:59 INFO - Return code: 0 22:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:13:59 INFO - Using env: {'DISPLAY': ':0', 22:13:59 INFO - 'HOME': '/home/cltbld', 22:13:59 INFO - 'LANG': 'en_US.UTF-8', 22:13:59 INFO - 'LANGUAGE': 'en_US:en', 22:13:59 INFO - 'LOGNAME': 'cltbld', 22:13:59 INFO - 'MAIL': '/var/mail/cltbld', 22:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:59 INFO - 'MOZ_NO_REMOTE': '1', 22:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:59 INFO - 'NO_EM_RESTART': '1', 22:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:59 INFO - 'PWD': '/builds/slave/test', 22:13:59 INFO - 'SHELL': '/bin/bash', 22:13:59 INFO - 'SHLVL': '1', 22:13:59 INFO - 'TERM': 'linux', 22:13:59 INFO - 'TMOUT': '86400', 22:13:59 INFO - 'USER': 'cltbld', 22:13:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:59 INFO - '_': '/tools/buildbot/bin/python'} 22:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:59 INFO - Running setup.py (path:/tmp/pip-P_elsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:59 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)) 22:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:59 INFO - Running setup.py (path:/tmp/pip-6EKIKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:14:00 INFO - Running setup.py (path:/tmp/pip-PdDdPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:14:00 INFO - Running setup.py (path:/tmp/pip-yUS_QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:14:00 INFO - Running setup.py (path:/tmp/pip-pG3Mc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:14:00 INFO - Running setup.py (path:/tmp/pip-1b2WQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:14:00 INFO - Running setup.py (path:/tmp/pip-sEsylM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:14:00 INFO - Running setup.py (path:/tmp/pip-HZRILq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:14:00 INFO - Running setup.py (path:/tmp/pip-fnMFhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:14:00 INFO - Running setup.py (path:/tmp/pip-JlAYLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:14:00 INFO - Running setup.py (path:/tmp/pip-qmozCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:14:00 INFO - Running setup.py (path:/tmp/pip-WaKQIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:14:00 INFO - Running setup.py (path:/tmp/pip-7cINdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:14:00 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)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:14:00 INFO - Running setup.py (path:/tmp/pip-RixxM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:14:00 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)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:00 INFO - Running setup.py (path:/tmp/pip-hADXi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:00 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)) 22:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:14:00 INFO - Running setup.py (path:/tmp/pip-Z1xuU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:14:01 INFO - Running setup.py (path:/tmp/pip-3ZouZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:14:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:02 INFO - Downloading blessings-1.6.tar.gz 22:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:14:03 INFO - Installing collected packages: blessings 22:14:03 INFO - Running setup.py install for blessings 22:14:03 INFO - Successfully installed blessings 22:14:03 INFO - Cleaning up... 22:14:03 INFO - Return code: 0 22:14:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:14:03 INFO - Reading from file tmpfile_stdout 22:14:03 INFO - Current package versions: 22:14:03 INFO - argparse == 1.2.1 22:14:03 INFO - blessings == 1.6 22:14:03 INFO - blobuploader == 1.2.4 22:14:03 INFO - docopt == 0.6.1 22:14:03 INFO - manifestparser == 1.1 22:14:03 INFO - mozInstall == 1.12 22:14:03 INFO - mozcrash == 0.17 22:14:03 INFO - mozdebug == 0.1 22:14:03 INFO - mozdevice == 0.48 22:14:03 INFO - mozfile == 1.2 22:14:03 INFO - mozhttpd == 0.7 22:14:03 INFO - mozinfo == 0.9 22:14:03 INFO - mozleak == 0.1 22:14:03 INFO - mozlog == 3.1 22:14:03 INFO - moznetwork == 0.27 22:14:03 INFO - mozprocess == 0.22 22:14:03 INFO - mozprofile == 0.28 22:14:03 INFO - mozrunner == 6.11 22:14:03 INFO - mozscreenshot == 0.1 22:14:03 INFO - mozsystemmonitor == 0.0 22:14:03 INFO - moztest == 0.7 22:14:03 INFO - mozversion == 1.4 22:14:03 INFO - psutil == 3.1.1 22:14:03 INFO - requests == 1.2.3 22:14:03 INFO - wsgiref == 0.1.2 22:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:14: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')]} 22:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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')]} 22:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:14:03 INFO - Using env: {'DISPLAY': ':0', 22:14:03 INFO - 'HOME': '/home/cltbld', 22:14:03 INFO - 'LANG': 'en_US.UTF-8', 22:14:03 INFO - 'LANGUAGE': 'en_US:en', 22:14:03 INFO - 'LOGNAME': 'cltbld', 22:14:03 INFO - 'MAIL': '/var/mail/cltbld', 22:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:03 INFO - 'MOZ_NO_REMOTE': '1', 22:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:03 INFO - 'NO_EM_RESTART': '1', 22:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:03 INFO - 'PWD': '/builds/slave/test', 22:14:03 INFO - 'SHELL': '/bin/bash', 22:14:03 INFO - 'SHLVL': '1', 22:14:03 INFO - 'TERM': 'linux', 22:14:03 INFO - 'TMOUT': '86400', 22:14:03 INFO - 'USER': 'cltbld', 22:14:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:03 INFO - '_': '/tools/buildbot/bin/python'} 22:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:14:03 INFO - Cleaning up... 22:14:03 INFO - Return code: 0 22:14:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:14: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')]} 22:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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')]} 22:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:14:03 INFO - Using env: {'DISPLAY': ':0', 22:14:03 INFO - 'HOME': '/home/cltbld', 22:14:03 INFO - 'LANG': 'en_US.UTF-8', 22:14:03 INFO - 'LANGUAGE': 'en_US:en', 22:14:03 INFO - 'LOGNAME': 'cltbld', 22:14:03 INFO - 'MAIL': '/var/mail/cltbld', 22:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:03 INFO - 'MOZ_NO_REMOTE': '1', 22:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:03 INFO - 'NO_EM_RESTART': '1', 22:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:03 INFO - 'PWD': '/builds/slave/test', 22:14:03 INFO - 'SHELL': '/bin/bash', 22:14:03 INFO - 'SHLVL': '1', 22:14:03 INFO - 'TERM': 'linux', 22:14:03 INFO - 'TMOUT': '86400', 22:14:03 INFO - 'USER': 'cltbld', 22:14:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:03 INFO - '_': '/tools/buildbot/bin/python'} 22:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:03 INFO - Downloading/unpacking jsonschema 22:14:03 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 22:14:03 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 22:14:03 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 22:14:03 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 22:14:03 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 22:14:03 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 22:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:14:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:14:05 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 22:14:05 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 22:14:05 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 22:14:05 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 22:14:05 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 22:14:05 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 22:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:14:05 INFO - warning: no files found matching '*.txt' 22:14:05 INFO - no previously-included directories found matching 'build' 22:14:05 INFO - no previously-included directories found matching 'dist' 22:14:05 INFO - no previously-included directories found matching '.git*' 22:14:05 INFO - Installing collected packages: jsonschema, functools32 22:14:06 INFO - Running setup.py install for functools32 22:14:06 INFO - warning: no files found matching '*.txt' 22:14:06 INFO - no previously-included directories found matching 'build' 22:14:06 INFO - no previously-included directories found matching 'dist' 22:14:06 INFO - no previously-included directories found matching '.git*' 22:14:06 INFO - Successfully installed jsonschema functools32 22:14:06 INFO - Cleaning up... 22:14:06 INFO - Return code: 0 22:14:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77a0735f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, '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': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', '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 22:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:14:06 INFO - Using env: {'DISPLAY': ':0', 22:14:06 INFO - 'HOME': '/home/cltbld', 22:14:06 INFO - 'LANG': 'en_US.UTF-8', 22:14:06 INFO - 'LANGUAGE': 'en_US:en', 22:14:06 INFO - 'LOGNAME': 'cltbld', 22:14:06 INFO - 'MAIL': '/var/mail/cltbld', 22:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:06 INFO - 'MOZ_NO_REMOTE': '1', 22:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:06 INFO - 'NO_EM_RESTART': '1', 22:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:06 INFO - 'PWD': '/builds/slave/test', 22:14:06 INFO - 'SHELL': '/bin/bash', 22:14:06 INFO - 'SHLVL': '1', 22:14:06 INFO - 'TERM': 'linux', 22:14:06 INFO - 'TMOUT': '86400', 22:14:06 INFO - 'USER': 'cltbld', 22:14:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:06 INFO - '_': '/tools/buildbot/bin/python'} 22:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:06 INFO - Downloading/unpacking flake8 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:14:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:14:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:14:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:14:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:14:08 INFO - no previously-included directories found matching 'docs/_build' 22:14:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:14:09 INFO - Running setup.py install for pep8 22:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:14:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:14:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:14:09 INFO - no previously-included directories found matching 'docs/_build' 22:14:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:14:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:14:09 INFO - Cleaning up... 22:14:09 INFO - Return code: 0 22:14:09 INFO - Running post-action listener: _resource_record_post_action 22:14:09 INFO - Running post-action listener: _start_resource_monitoring 22:14:09 INFO - Starting resource monitoring. 22:14:09 INFO - ##### 22:14:09 INFO - ##### Running install step. 22:14:09 INFO - ##### 22:14:09 INFO - Running pre-action listener: _resource_record_pre_action 22:14:09 INFO - Running main action method: install 22:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:14:09 INFO - Reading from file tmpfile_stdout 22:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:14:09 INFO - Reading from file tmpfile_stdout 22:14:09 INFO - Output received: 22:14:09 INFO - Usage: mozinstall [options] installer 22:14:09 INFO - Options: 22:14:09 INFO - -h, --help show this help message and exit 22:14:09 INFO - -d DEST, --destination=DEST 22:14:09 INFO - Directory to install application into. [default: 22:14:09 INFO - "/builds/slave/test"] 22:14:09 INFO - --app=APP Application being installed. [default: firefox] 22:14:09 INFO - mkdir: /builds/slave/test/build/application 22:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:14:25 INFO - Reading from file tmpfile_stdout 22:14:25 INFO - Output received: 22:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 22:14:25 INFO - Running post-action listener: _resource_record_post_action 22:14:25 INFO - ##### 22:14:25 INFO - ##### Running run-tests step. 22:14:25 INFO - ##### 22:14:25 INFO - Running pre-action listener: _resource_record_pre_action 22:14:25 INFO - Running main action method: run_tests 22:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:14:25 INFO - Python 2.7.3 22:14:25 INFO - Return code: 0 22:14:25 INFO - grabbing minidump binary from tooltool 22:14: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')]} 22:14:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe410>, '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 0x1bff310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bff7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:14:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:14:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:14:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:14:25 INFO - Return code: 0 22:14:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:14:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:14:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:14:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:14:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:14:26 INFO - Return code: 0 22:14:26 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:14:26 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:14:26 INFO - Using env: {'DISPLAY': ':0', 22:14:26 INFO - 'HOME': '/home/cltbld', 22:14:26 INFO - 'LANG': 'en_US.UTF-8', 22:14:26 INFO - 'LANGUAGE': 'en_US:en', 22:14:26 INFO - 'LOGNAME': 'cltbld', 22:14:26 INFO - 'MAIL': '/var/mail/cltbld', 22:14:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:14:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:26 INFO - 'MOZ_NO_REMOTE': '1', 22:14:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:26 INFO - 'NO_EM_RESTART': '1', 22:14:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:26 INFO - 'PWD': '/builds/slave/test', 22:14:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:14:26 INFO - 'SHELL': '/bin/bash', 22:14:26 INFO - 'SHLVL': '1', 22:14:26 INFO - 'TERM': 'linux', 22:14:26 INFO - 'TMOUT': '86400', 22:14:26 INFO - 'USER': 'cltbld', 22:14:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928', 22:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:26 INFO - '_': '/tools/buildbot/bin/python'} 22:14:26 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:14:26 INFO - mozversion application_buildid: 20160404203620 22:14:26 INFO - mozversion application_changeset: fd37367d1b1f2952c7a970c4b41e650d7233c717 22:14:26 INFO - mozversion application_display_name: Nightly 22:14:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:14:26 INFO - mozversion application_name: Firefox 22:14:26 INFO - mozversion application_remotingname: firefox 22:14:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:14:26 INFO - mozversion application_vendor: Mozilla 22:14:26 INFO - mozversion application_version: 48.0a1 22:14:26 INFO - mozversion platform_buildid: 20160404203620 22:14:26 INFO - mozversion platform_changeset: fd37367d1b1f2952c7a970c4b41e650d7233c717 22:14:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:14:26 INFO - mozversion platform_version: 48.0a1 22:14:26 INFO - using testdate: 1459833266 22:14:26 INFO - actual date: 1459833266 22:14:26 INFO - starting webserver on 'localhost:48774' 22:14:26 INFO - SUITE-START | Running 2 tests 22:14:26 INFO - TEST-START | dromaeo_css 22:14:26 INFO - operating with platform_type : linux_ 22:14:26 INFO - Initialising browser for dromaeo_css test... 22:14:26 INFO - TEST-INFO | started process 5446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0imfkG/profile http://localhost:48774/getInfo.html) 22:14:30 INFO - PROCESS | 5446 | __metrics Screen width/height:1600/1200 22:14:30 INFO - PROCESS | 5446 | colorDepth:24 22:14:30 INFO - PROCESS | 5446 | Browser inner width/height: 1024/697 22:14:30 INFO - PROCESS | 5446 | __metrics 22:14:31 ERROR - PROCESS | 5446 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:14:32 INFO - TEST-INFO | 5446: exit 0 22:14:32 INFO - Browser initialized. 22:14:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:32 INFO - TEST-INFO | started process 5526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0imfkG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:44 INFO - PROCESS | 5526 | RSS: Main: 154005504 22:14:44 INFO - PROCESS | 5526 | 22:15:35 INFO - PROCESS | 5526 | 1459833335683 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] 22:17:47 INFO - PROCESS | 5526 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48774/tests/dromaeo/cssquery-ext.html) 22:17:47 INFO - PROCESS | 5526 | RSS: Main: 236736512 22:17:47 INFO - PROCESS | 5526 | 22:20:50 INFO - PROCESS | 5526 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-ext.html (next: http://localhost:48774/tests/dromaeo/cssquery-jquery.html) 22:20:50 INFO - PROCESS | 5526 | RSS: Main: 231288832 22:20:50 INFO - PROCESS | 5526 | 22:23:52 INFO - PROCESS | 5526 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48774/tests/dromaeo/cssquery-mootools.html) 22:23:53 INFO - PROCESS | 5526 | RSS: Main: 238325760 22:23:53 INFO - PROCESS | 5526 | 22:26:55 INFO - PROCESS | 5526 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48774/tests/dromaeo/cssquery-prototype.html) 22:26:55 INFO - PROCESS | 5526 | RSS: Main: 220454912 22:26:55 INFO - PROCESS | 5526 | 22:29:58 INFO - PROCESS | 5526 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48774/tests/dromaeo/cssquery-yui.html) 22:29:58 INFO - PROCESS | 5526 | RSS: Main: 199585792 22:29:58 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | Cycle 1(1): loaded http://localhost:48774/tests/dromaeo/cssquery-yui.html (next: http://localhost:48774/tests/dromaeo/cssquery-dojo.html) 22:33:01 INFO - PROCESS | 5526 | RSS: Main: 262434816 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | __start_tp_report 22:33:01 INFO - PROCESS | 5526 | _x_x_mozilla_page_load 22:33:01 INFO - PROCESS | 5526 | _x_x_mozilla_page_load_details 22:33:01 INFO - PROCESS | 5526 | |i|pagename|runs| 22:33:01 INFO - PROCESS | 5526 | |0;dojo.html;2616.777573906218;2688.1129227354977;2693.138195777352;2699.1362763915545;2729.1676038808164;4550.317452382144;4592.035672508773;4618.74596897171;4621.376114224583;4630.00454902196;4584.839530616429;4609.654275929311;4632.652551058667;4644.5587669171455;4723.29150627406;4266.44536210293;4275.935860962072;4289.378040184171;4319.0498090420215;4436.534163912775;4358.891027724317;4382.583654552813;4398.098389830077;4409.316555933835;4438.090191510732;4222.598853108965;4282.5503322151035;4297.527272000078;4355;4361.890952726176;4219.852305169305;4249.043965107857;4254.191703576311;4282.593153650399;4311.116221174651;4163.3130533462245;4256.170046840867;4261.701680882339;4266.91466170678;4301.741895486281;4512.909741805145;4515.322701594754;4529.230030894756;4611.354410382549;4627.329037289608;4943.6539442239055;4951.455339912607;4955.405351357824;4963.156263435225;4972.502749725035;4960.280759289919;4975.552200301954;4977.054359671687;4981.576565991895;5037.647364684473;4511.278195488706;4595.931061034087;4610.953890461086;4687.67186296956;4690.882727931761;4998.5751211146735;5027.271045698353;5038.571721403649;5041.243813427942;5070.771815268322;4809.711417314972;4813.975930120397;4816.783244753994;4827.686200396963;4872.561469467765;4811.422629284439;4911.901761964812;4966.180580204298;4982.252662100642;4993.6005119590345;4826.758662066883;4843.39457567804;4856.3201151838775;4865.245886887538;4889.291052797395;4844.757762111951;4844.806207751651;4847.95152048475;4849.321095046696;4897.265410188429;4091.488563929509;4151.771652559078;4156.293430116887;4160.687948403882;4161.0221597924465;3616.65641764032;3655.5978842327854;3670.889873303805;3672.3022625701033;3675.246574452231;4214.093969796509;4218.156368726267;4220.746755194698;4262.978685106555;4322.848700295474;4991.176455884811;4992.226204938241;4999.075171093359;5000.374953130859;5030.220315851049;4307.1601037797955;4307.719998200107;4317.050248945227;4343.782810859444;4355.73865568067;4384.583464570861;4450.06548624786;4489.7979590918485;4531.932021019687;4533.229351010336;4659.301104834234;4668.11305851887;4669.369635099218;4670.392848929618;4716.268978308436;4885.633577481632;4933.889874778146;4934.111859865258;4938.037082768969;4989.650724449254;4563.49801521839;4664.953350466452;4701.506341834195;4735.857924262277;4751.073540659539;4828.637852161031;4842.95157048425;4851.442084160367;4852.344933434082;4895.290182923527;4791.305260737243;4903.117438861039;4908.656394052382;4910.582600478856;4956.752162391938;4791;4820.8794780130775;4822.734749588806;4828.589569886599;4874.341963834837;4729.077829823152;4759.5240475953515;4760.857174284777;4770.0936822003705;4811.951880481291;4618.445786505641;4696.718196908197;4728.0780247851335;4728.881777955578;4773.570378665937;4864.878378040436;4881.365422495053;4884.78018489176;4886.95113048865;4934.383202099738;4752;4756.215224488059;4765.9046819064115;4767.141914455431;4796.8081276748535 22:33:01 INFO - PROCESS | 5526 | |1;ext.html;498.17551951520244;519.5220397234544;529.6239669834417;537.9623426360154;551.5477308606942;27850.164495065153;28421;36321.45517817235;36699.4495082574;36753.81623091888;39374.8031259844;40165.7991710041;40180.39729404061;40216.79891600545;40217.195656086864;7750.92249077509;7961.283484486395;7963.124056353797;7963.8805417918775;7967.840643187162;7869.606519674022;8037.598120094001;8038.8794168087525;8040.396970227227;8041.55771432571;8001.079875814268;8053.758387248363;8056.274935255826;8070.959645201795;8076.152004039579;7969.641366138509;8004.559749213791;8045.275925166763;8051.718189863356;8056.798580035487;7933.484323518953;8082.43422960393;8087.676492940275;8092.231238032377;8093.352531797442;38442.80778596089;38764;38791.22417551661;39023.804880975695;39041.60958390408;3107.6736942620923;3173.698498642625;3270.8364581770816;3374.156460884779;3530.5586801649793;26046.73953260462;26266.080687175858;26340.473190536275;26354.20937371882;26364.077257296096;3387.627360990289;3501.229729459515;3616.692581130607;3631.092226943264;3696.667299943018;179397;181028;181154.09422952932;181475;181659;60734.39265607376;60917.39082609206;61394.69302653458;61406;61417.38582614206;65584.67207664027;65642.67178664172;65692;65892;65917;16285.267162977694;16414.343426263054;16501.83498165027;16544.6691066178;16557.25492352847;12365.38173091342;12534.68663283407;12537.310447925269;12538.81191782124;12542.498300067895;19588.608227835364;20647.17411303561;21106.15575376968;21117.57764844725;21133;5652.406497317805;7222.313880181479;7375.668094935741;7482.214367491444;7720.42096842739;898.6630013744846;900.9144131307515;1016.9288149829441;1028.881678606955;1034.343192073039;26579.601305980425;27244;27318.453630927666;27338.863305683346;27441.039563615177;989.5151375825793;1031.0926384781494;1048.119579553179;1050.6375300521308;1117.8323251512174;14244.786328205086;14268.126805730797;14282.21447820359;14543.27283635814;14653.633659158393;283735;286146;288119;289417;289968;48656;49745;49778.50221497739;49784.50215497871;49821;1042.9791404171874;1226.9631911042504;1230.2864338683542;1237.5297386992886;1270.5489551209187;24464.143754968492;25618.61572076383;25743.871280643478;25746.871265644302;25860.482790344464;36587.268254634226;36769;36986.44520332143;37018.629813702595;37023.62976370202;170905;171860.1406993007;171927.28072719113;172409;172577;32999.845005425654;33214.66785332116;33445.83277083599;33719.4942075874;34045.319093617494;42176.15647686968;42200.78899605482;42224;42528;43271.783641081594;35157.47263791096;35740.82129589335;36255.45616815802;36357.27285454329;36414.63585364113;35474.467882982295;35699.28601427905;35716;35824.596663316945;35928.64071359253;35762.64237357593;35825;36110.819445902605;36147;36521.269574608894;31310;32311;32361.51457728089;32395.676043239266;32480.675193247764;25337.366565836;25496.617550737126;25523.87238063872;25529.617055743805;25849.353766155244 22:33:01 INFO - PROCESS | 5526 | |2;jquery.html;349.0418800392921;351.5254406551156;352.7195879275977;364.10793555788325;366.3058504134665;15616.687666246668;15938.920305398471;16984.915075424637;17494.65010699785;17502.299908003664;16306.673866522662;16717.498475045737;16751.413700520483;16802;16847.157642117905;4954.232094025432;5021.447640759514;5138.871528211787;5145.794168233285;5154.32993710817;5145.794168233266;5165.845024649267;5186.611004174683;5187.092258854705;5210.036143313499;5048.368953880765;5068.366454193226;5081.46644602317;5116.897662046776;5121.641485096045;4999.925001124986;5062.7468626568525;5116.974415127937;5128.076946149691;5135.204043373283;4564.8402305919135;4571.291449825249;4572.0627271409285;4572.5427457254345;4574;18199.090045497804;19377.321793737294;20320.390388288375;20335.4916127098;20338.389848304574;1988.721578978944;2208.8122509586706;2328.930132096023;2390.5457962986975;2447.5716749568755;8936.553172341422;9097.181253687133;9329.906700932972;9347.672831450935;9399.060093990614;1734.6964281250857;1817.4365946556609;1822.8541716662635;1833.6424397242542;1850.9629807403776;60946.390536094514;64496.677516612115;64926.3507364925;64996.675016625086;66002.66998664977;9632.9036709632;9841.32343011477;9856.063673950963;10026.398416095057;10058.094771470604;13365.732685346238;13370.665733356744;13421.66445838862;13431.328433578283;13441.529546465827;7274.381677557361;7283.781486555412;7417.962910185523;7539.962300188464;7556.848863022708;7155.17715462718;7165.0685410897295;7196.46026548011;7292.416606671453;7314.08573928259;4278.465191851019;4318.093200427883;4324.978375108104;4347.282698354736;4389.31965545341;1774.1661419132986;1785.2055835153233;1825.771778527684;1849.6485667723089;1852.3424184414607;839.1482645115213;872.1148034744739;904.5296445848122;909.6543313540813;913.1097180249204;15661.765073523906;15898;16095.919520402324;16225.59436014109;16314.428994985119;870.0994470722771;876.7369789063383;893.5576889439769;907.6006557114848;939.5302348825587;8833.823323533494;9201;9261.008883090168;9400.905990940004;9516.476593787409;315054;318354;318900;382564;424659;55026.724866375414;64717;69016.30983690098;71960;72026;439.86364227089706;451.46726862302796;453.8956040110793;457.4487742270556;457.58131309851115;8627.611757471055;9695.854562181432;10078.244131690006;10306.896931030593;10642.680719578426;32199.35601288008;32274.35451291008;32892.67107328896;33342.83328583342;34590.82704586461;39886.40170397388;41967.58032419759;42686.78656606697;42833.785831071895;43305.350419743096;7658.2724641159;7675.155732869492;7752.5348479091435;7964.9203507966495;8015.599220039091;11375.374354410256;11625.302481851117;11918.582849600223;11935.582254621047;12110.576129835414;10251.128654064489;10378.325408848401;10433.478326083818;10541.736456588647;10730.141588672732;10159.796804064024;10447.373157610567;10478.738031548968;10497.475126243504;10527.894721052999;10417.114545263737;10459.215558832966;10483.52824122901;10492.422916739348;10719.14246860265;7676;7699.769006929801;7741.7677469676;7828.060632724109;7896.289333959971;9579.185769209416;10225.279106858232;10425.165986720893;10503.159747220358;10597.523111459848 22:33:01 INFO - PROCESS | 5526 | |3;mootools.html;1387.2439520461348;1407.6340151560594;1519.817621885374;1686.603648142687;1732.4282986614419;6775.1531058617675;6816.659167041653;6975.651217439133;6987.021816945632;6988.405985491239;6058.545609079326;6184.165137706408;6668.76659316924;6805.795826125224;6866.862662746755;2164.318239754476;2196.6375548034557;2198.329509499602;2198.5163264081875;2200.4388880835445;2118.0998075817793;2141.550274442369;2165.577712346093;2166.9783302166934;2167.2414654870827;1786.740922566227;2107.357256036908;2139.2833400810746;2159.222679835258;2160.9135634574677;2069.213698794456;2076.397844625057;2107.673310636854;2108.399106254718;2110.8311335093154;2084;2119.5337025854287;2120.257909731597;2121.31057406342;2123.214410668047;6853.520253582202;6893.069435626227;6895.793126206222;6909.481788865855;6924.649693309807;4318.632916202127;4427.158839820424;4433.290673492225;4446.021875187454;4451.732896026248;2841.602175695404;2875.051233093074;2943;2954.822710637347;2970.643522777259;923.9584218710174;967.4727273635885;968;986.2110311750642;986.8914419413859;8792.252658523968;9357.906420935771;9371.812563748686;9396.295277854188;9397.718068457958;3930.8231129599235;4042;4045.7572545647354;4084.4077608746566;4104.610062044101;8128.227818357246;8155.5514446706;8162.30620397261;8163.387745918961;8180.386471014579;4436.64506839452;4450.198964186413;4452.799624016927;4454.131444368382;4455.754933478625;3387.2209391840015;3872.786996715208;3944.9211015780097;4020.1758639478835;4022.1553473770837;3427.537282466885;3436.742244331685;3486.4770284457027;3516.4197907345;3518.296340731864;1138.0440430038807;1144.8511693479795;1152.8558930133734;1158.478684591937;1159.3449700919123;1192.4455128365353;1193.7910865598485;1201.3212534917743;1216.2520050169082;1216.6289281768968;6533.575317604341;6676.9666151668935;6685.431738302299;6721.22705888829;6726.3609957054005;470.6916969385058;472.480271701126;473.79863557987716;484.70433035848106;486.6860874735776;4987.650864439454;5065.797368105308;5070.670406423571;5119.360079990001;5123.410807757081;8217.301529369952;8294.58527073656;8516.190961858614;8531.957340213383;8648.69729559475;8429.283510901641;8481.618327175293;8519.872201916976;8576.399652024298;8582.742517724479;6638.601683898885;6703.29615390377;6750.426213771884;6763.222229443677;6832.555883867532;6398.296187419473;6471.158749362553;6482.513811464065;6486.967565162144;6491.448226900767;7373.29953654402;7551.509151905108;7623.352015078781;7654.540727556365;7756.457048006811;7748.728794492165;7882.448228623941;7884.0144981877265;7955.840883182188;7992.120866704774;5471.206675032177;5890.617109888015;6130.2030736004035;6319.968400158154;6382;6638.83402914931;6651.767188148391;6655.733770649314;6691.029800678972;6703.262641109572;6002.8499287516415;6091.269047714302;6168.982117950488;6212.534059945432;6218.378162183745;5967.104934259895;6009.128676341818;6022.698865056817;6106.9083963739695;6110.388961104032;6320.273168585672;6447.290798012309;6448.871022579616;6451.774187903401;6454.774082907075;5865.501432378295;5962.880742385041;5965.731542080704;5965.791197308247;5968.239369385955;6029.457348838626;6043.214382130295;6063.333033366238;6096.390360963868;6117.694115294128 22:33:01 INFO - PROCESS | 5526 | |4;prototype.html;309.81565968248884;316.58053079669435;322.2941757550965;322.4341281051754;323.90282915125454;5286.259923610698;5413.43158968308;5428.294321738178;5437.8368648940495;5438.510534051935;5232.529072383485;5393.352797664276;5417.10617748072;5423.83728488146;5438.238646589471;3945.4279129526203;4027.234825383168;4101.364288535282;4156.480439945014;4158.9376159357635;4094.97952510237;4124.463819703449;4127.360259159835;4132.318167502359;4145.730527515717;4077.3883917412477;4085.101277718897;4100.56944020878;4108.5686002969705;4112.814923328442;3905.8632947846972;4023.054582173216;4086.4074709167303;4096.877093687194;4102.446169767073;3567.928641427183;3573.6247693992277;3574.3566158091794;3579.7673151245085;3590.4793804898404;5113.130767769451;5143.6399452037995;5145.562627176694;5147.613928955343;5148.2535032420465;4735.597474214662;4741.099191153669;4748.477667456612;4750.738709370983;4751.809927602892;5593.636413633101;5635.098384258499;5638.548916086703;5645.491905728504;5647.8588035299035;3929.390944403622;3939.4484772131923;3943.211357728437;3944.9211015779524;3955.248502784462;5666.093425051972;5878.588498805086;5965.970170149165;5985.25184351956;5996.670183139926;4004.3593025115842;4027.81874815634;4041.7372870763306;4042.939355909664;4050.4531888195306;4091.5499295077516;4094.7133700641266;4097.774622395737;4100.671946244293;4102.528209255914;4713.552212539803;4730.030343779517;4730.668853180245;4734.597559207506;4739.620830333634;5677.3471050829685;5699.145128230715;5708.20085188074;5715.257016587817;5721.5136713379;1417.3551034279378;1439.2803598200899;1443.3216388297483;1445.0534899640752;1445.8915581331232;882.8101958079044;920.9539523023822;942.7266092833139;948.7296120605595;975.5268694683073;4891.144049791273;5012.298278241049;5025.572826309804;5029.245613158056;5037.798488060436;5887.8233652990475;5904.704764761745;5907.1434641976675;5915.260592425947;5919.467247947619;5004.374453193351;5006.899862002812;5012;5013.448520662724;5021.774020169101;3140.0422871024102;3171.8572664230164;3177.7298929591243;3177.7616678749187;3178.411993781158;5538.446155384429;5550.805721799798;5558.637579028897;5569.220309156722;5570.41510641385;5831.446012628879;6055.303640081359;6061.121137435047;6076.240469941257;6082.148499210114;5522.6134170607675;5531.0873705838085;5535.861603459865;5557.221988921635;5557.360903496069;5891.675957822361;5892.6759028253855;5895.9705201475435;5904.468597826216;5907.881842363215;5793.420657934173;5800.56495762811;5806.535477161901;5816.70916454184;5828.94171058301;5557.861053473695;5559.805406810742;5560.110382338807;5560.527355174855;5562.805301814579;3933.1347103637154;4041.4948131483566;4044.6157615026527;4049.1901619675596;4054.2499637567144;5830.329512105993;5837.416258374129;5869.266341707286;5875.882482350415;5878.265216847894;5660.971695141498;5665.178549110438;5667.093265077568;5675.687837168995;5676.2337084493065;5655.519280861173;5658.971705141448;5659.575531835211;5665.405132461032;5669.716514174357;5427.592930530305;5530.944690553204;5571.554275657856;5588.77644894216;5595.160725891149;5731.713414329351;5748.971255143698;5752.050911599539;5753.510951569164;5754.712264386848;5596.692181930033;5600.4959553640365;5602.299712535933;5608.327000759935;5613.410591887793 22:33:01 INFO - PROCESS | 5526 | |5;yui.html;679.6363945289271;695.7703957693958;754.4153281207064;775.8564665536876;782.7103971530532;13673.521426750054;13704.24626645534;13714.931425342871;13778.379972901219;13783.310834458262;13881.722365552683;13897.305134743248;13925.93037034816;13945.372458239379;14000.929995350034;652.6475703120333;818.758466252457;824.9340052795762;834.5952213176635;834.6160766047625;836.1596595421593;839.5927974932154;841.7769291137853;844.0630899701326;844.3456321350941;868.9695860644879;880.2034159086005;880.6873559886244;880.8810810540559;880.8898887639045;673.7170388436843;856.6273670953155;866.5234121233328;873.9344549158839;875.2735229759285;635.8760041791852;636.2937139774846;636.3509220594967;636.4876274598946;636.5130675033603;13349.466021359134;13450.730985380336;13551.186928784304;13569.660758481019;13601;11574;11779.823302650468;12018.218815776947;12048.457819398149;12275.324857132855;9215.400998935047;9410.106039926197;9450.385724927926;9485.905140948571;9568.856467152998;3314.5691060162026;3329.883454079096;3367.696907278357;3415.0608582639725;3455.015320633607;43476.3478547822;43791.34312985308;43856.3421548677;43965.99999999968;43984.780076099734;9687.999999999858;9753.609855605839;9826.65606703762;9827;9870.358426702242;15920.283587238602;15968.520944371687;16313;16365;16387.83612163887;6367.076773867856;6562.606243625398;6642.202935647657;6661.26726060133;6724.428423583952;3716.089558058293;3731.1231860512758;3747.4191500317493;3761.6050314716563;3852.653261206505;2755.875985580654;2767.958480622792;2778.180436771117;2781.694013658496;2781.9428617125363;492.4312419155881;498.8952320012838;505.1336957118559;507.55382846266235;515.222014757711;502.0836972525156;522.3940229333955;622.9596573721805;630.5145038320559;633.6514916795744;7811.609419529001;7815.413843961725;7981.840363192704;8078.35373170145;8139.30815880645;469.143812542112;487.32018833726755;537.857467771041;568.9630174038674;632.6141053957083;3611.331903597843;3636.254567813592;3643.1620727232353;3729.4592284118653;3821.7133714971487;47508.7624561875;47828.28257576139;48277.275840862414;48413.5158648409;48911;43170.84145792698;44027.559724402985;44165;44353.11293774171;44741;38117;40136.799316003235;40218.99452513652;40660;40788.79605601953;7036;7048.823779405556;7049.7885063448175;7194.388476979515;7197.388222001188;30076.699233008265;30151.698483015767;30898.38203235878;31152.37695246037;31906.68093319037;36729.26541469209;39662;39765;40096.79951600223;40132.79933600313;9067.863982040142;9148.451092934445;9179.127982841619;9205.355625106446;9227.44635321883;9723.270754693567;9918.752031199278;9922.900770992197;9926.801463970536;9948.403095814274;9256.398334108262;9283.953580232055;9284.72145835626;9300.20948219409;9307.674231401868;9729.659461918798;9783.46190959504;9803.16673082796;9816.165625921876;9844;9367.859482107637;9396.577154028222;9449;9471.810563788824;9484.810303794024;8106.270435660583;8185.549794761345;8344.249017588203;8393.790155245924;8418.116097809641;7960.522368657899;8127.431079824592;8193.262606365455;8344.249017588447;8461.196186362286 22:33:01 INFO - PROCESS | 5526 | __end_tp_report 22:33:01 INFO - PROCESS | 5526 | __start_cc_report 22:33:01 INFO - PROCESS | 5526 | _x_x_mozilla_cycle_collect,853 22:33:01 INFO - PROCESS | 5526 | __end_cc_report 22:33:01 INFO - PROCESS | 5526 | __startTimestamp1459834381439__endTimestamp 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | ------- Summary: start ------- 22:33:01 INFO - PROCESS | 5526 | Number of tests: 6 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | [#0] dojo.html Cycles:165 Average:4574.34 Median:4701.51 stddev:457.15 (9.7%) stddev-sans-first:431.99 22:33:01 INFO - PROCESS | 5526 | Values: 2616.8 2688.1 2693.1 2699.1 2729.2 4550.3 4592.0 4618.7 4621.4 4630.0 4584.8 4609.7 4632.7 4644.6 4723.3 4266.4 4275.9 4289.4 4319.0 4436.5 4358.9 4382.6 4398.1 4409.3 4438.1 4222.6 4282.6 4297.5 4355.0 4361.9 4219.9 4249.0 4254.2 4282.6 4311.1 4163.3 4256.2 4261.7 4266.9 4301.7 4512.9 4515.3 4529.2 4611.4 4627.3 4943.7 4951.5 4955.4 4963.2 4972.5 4960.3 4975.6 4977.1 4981.6 5037.6 4511.3 4595.9 4611.0 4687.7 4690.9 4998.6 5027.3 5038.6 5041.2 5070.8 4809.7 4814.0 4816.8 4827.7 4872.6 4811.4 4911.9 4966.2 4982.3 4993.6 4826.8 4843.4 4856.3 4865.2 4889.3 4844.8 4844.8 4848.0 4849.3 4897.3 4091.5 4151.8 4156.3 4160.7 4161.0 3616.7 3655.6 3670.9 3672.3 3675.2 4214.1 4218.2 4220.7 4263.0 4322.8 4991.2 4992.2 4999.1 5000.4 5030.2 4307.2 4307.7 4317.1 4343.8 4355.7 4384.6 4450.1 4489.8 4531.9 4533.2 4659.3 4668.1 4669.4 4670.4 4716.3 4885.6 4933.9 4934.1 4938.0 4989.7 4563.5 4665.0 4701.5 4735.9 4751.1 4828.6 4843.0 4851.4 4852.3 4895.3 4791.3 4903.1 4908.7 4910.6 4956.8 4791.0 4820.9 4822.7 4828.6 4874.3 4729.1 4759.5 4760.9 4770.1 4812.0 4618.4 4696.7 4728.1 4728.9 4773.6 4864.9 4881.4 4884.8 4887.0 4934.4 4752.0 4756.2 4765.9 4767.1 4796.8 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | [#1] ext.html Cycles:180 Average:39111.76 Median:35751.73 stddev:57416.68 (160.6%) stddev-sans-first:57504.55 22:33:01 INFO - PROCESS | 5526 | Values: 498.2 519.5 529.6 538.0 551.5 27850.2 28421.0 36321.5 36699.4 36753.8 39374.8 40165.8 40180.4 40216.8 40217.2 7750.9 7961.3 7963.1 7963.9 7967.8 7869.6 8037.6 8038.9 8040.4 8041.6 8001.1 8053.8 8056.3 8071.0 8076.2 7969.6 8004.6 8045.3 8051.7 8056.8 7933.5 8082.4 8087.7 8092.2 8093.4 38442.8 38764.0 38791.2 39023.8 39041.6 3107.7 3173.7 3270.8 3374.2 3530.6 26046.7 26266.1 26340.5 26354.2 26364.1 3387.6 3501.2 3616.7 3631.1 3696.7 179397.0 181028.0 181154.1 181475.0 181659.0 60734.4 60917.4 61394.7 61406.0 61417.4 65584.7 65642.7 65692.0 65892.0 65917.0 16285.3 16414.3 16501.8 16544.7 16557.3 12365.4 12534.7 12537.3 12538.8 12542.5 19588.6 20647.2 21106.2 21117.6 21133.0 5652.4 7222.3 7375.7 7482.2 7720.4 898.7 900.9 1016.9 1028.9 1034.3 26579.6 27244.0 27318.5 27338.9 27441.0 989.5 1031.1 1048.1 1050.6 1117.8 14244.8 14268.1 14282.2 14543.3 14653.6 283735.0 286146.0 288119.0 289417.0 289968.0 48656.0 49745.0 49778.5 49784.5 49821.0 1043.0 1227.0 1230.3 1237.5 1270.5 24464.1 25618.6 25743.9 25746.9 25860.5 36587.3 36769.0 36986.4 37018.6 37023.6 170905.0 171860.1 171927.3 172409.0 172577.0 32999.8 33214.7 33445.8 33719.5 34045.3 42176.2 42200.8 42224.0 42528.0 43271.8 35157.5 35740.8 36255.5 36357.3 36414.6 35474.5 35699.3 35716.0 35824.6 35928.6 35762.6 35825.0 36110.8 36147.0 36521.3 31310.0 32311.0 32361.5 32395.7 32480.7 25337.4 25496.6 25523.9 25529.6 25849.4 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | [#2] jquery.html Cycles:180 Average:22228.20 Median:23815.16 stddev:58423.49 (245.3%) stddev-sans-first:58564.29 22:33:01 INFO - PROCESS | 5526 | Values: 349.0 351.5 352.7 364.1 366.3 15616.7 15938.9 16984.9 17494.7 17502.3 16306.7 16717.5 16751.4 16802.0 16847.2 4954.2 5021.4 5138.9 5145.8 5154.3 5145.8 5165.8 5186.6 5187.1 5210.0 5048.4 5068.4 5081.5 5116.9 5121.6 4999.9 5062.7 5117.0 5128.1 5135.2 4564.8 4571.3 4572.1 4572.5 4574.0 18199.1 19377.3 20320.4 20335.5 20338.4 1988.7 2208.8 2328.9 2390.5 2447.6 8936.6 9097.2 9329.9 9347.7 9399.1 1734.7 1817.4 1822.9 1833.6 1851.0 60946.4 64496.7 64926.4 64996.7 66002.7 9632.9 9841.3 9856.1 10026.4 10058.1 13365.7 13370.7 13421.7 13431.3 13441.5 7274.4 7283.8 7418.0 7540.0 7556.8 7155.2 7165.1 7196.5 7292.4 7314.1 4278.5 4318.1 4325.0 4347.3 4389.3 1774.2 1785.2 1825.8 1849.6 1852.3 839.1 872.1 904.5 909.7 913.1 15661.8 15898.0 16095.9 16225.6 16314.4 870.1 876.7 893.6 907.6 939.5 8833.8 9201.0 9261.0 9400.9 9516.5 315054.0 318354.0 318900.0 382564.0 424659.0 55026.7 64717.0 69016.3 71960.0 72026.0 439.9 451.5 453.9 457.4 457.6 8627.6 9695.9 10078.2 10306.9 10642.7 32199.4 32274.4 32892.7 33342.8 34590.8 39886.4 41967.6 42686.8 42833.8 43305.4 7658.3 7675.2 7752.5 7964.9 8015.6 11375.4 11625.3 11918.6 11935.6 12110.6 10251.1 10378.3 10433.5 10541.7 10730.1 10159.8 10447.4 10478.7 10497.5 10527.9 10417.1 10459.2 10483.5 10492.4 10719.1 7676.0 7699.8 7741.8 7828.1 7896.3 9579.2 10225.3 10425.2 10503.2 10597.5 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | [#3] mootools.html Cycles:180 Average:4932.77 Median:6026.08 stddev:2503.32 (41.5%) stddev-sans-first:2496.16 22:33:01 INFO - PROCESS | 5526 | Values: 1387.2 1407.6 1519.8 1686.6 1732.4 6775.2 6816.7 6975.7 6987.0 6988.4 6058.5 6184.2 6668.8 6805.8 6866.9 2164.3 2196.6 2198.3 2198.5 2200.4 2118.1 2141.6 2165.6 2167.0 2167.2 1786.7 2107.4 2139.3 2159.2 2160.9 2069.2 2076.4 2107.7 2108.4 2110.8 2084.0 2119.5 2120.3 2121.3 2123.2 6853.5 6893.1 6895.8 6909.5 6924.6 4318.6 4427.2 4433.3 4446.0 4451.7 2841.6 2875.1 2943.0 2954.8 2970.6 924.0 967.5 968.0 986.2 986.9 8792.3 9357.9 9371.8 9396.3 9397.7 3930.8 4042.0 4045.8 4084.4 4104.6 8128.2 8155.6 8162.3 8163.4 8180.4 4436.6 4450.2 4452.8 4454.1 4455.8 3387.2 3872.8 3944.9 4020.2 4022.2 3427.5 3436.7 3486.5 3516.4 3518.3 1138.0 1144.9 1152.9 1158.5 1159.3 1192.4 1193.8 1201.3 1216.3 1216.6 6533.6 6677.0 6685.4 6721.2 6726.4 470.7 472.5 473.8 484.7 486.7 4987.7 5065.8 5070.7 5119.4 5123.4 8217.3 8294.6 8516.2 8532.0 8648.7 8429.3 8481.6 8519.9 8576.4 8582.7 6638.6 6703.3 6750.4 6763.2 6832.6 6398.3 6471.2 6482.5 6487.0 6491.4 7373.3 7551.5 7623.4 7654.5 7756.5 7748.7 7882.4 7884.0 7955.8 7992.1 5471.2 5890.6 6130.2 6320.0 6382.0 6638.8 6651.8 6655.7 6691.0 6703.3 6002.8 6091.3 6169.0 6212.5 6218.4 5967.1 6009.1 6022.7 6106.9 6110.4 6320.3 6447.3 6448.9 6451.8 6454.8 5865.5 5962.9 5965.7 5965.8 5968.2 6029.5 6043.2 6063.3 6096.4 6117.7 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | [#4] prototype.html Cycles:180 Average:4691.66 Median:5425.72 stddev:1393.93 (25.7%) stddev-sans-first:1358.49 22:33:01 INFO - PROCESS | 5526 | Values: 309.8 316.6 322.3 322.4 323.9 5286.3 5413.4 5428.3 5437.8 5438.5 5232.5 5393.4 5417.1 5423.8 5438.2 3945.4 4027.2 4101.4 4156.5 4158.9 4095.0 4124.5 4127.4 4132.3 4145.7 4077.4 4085.1 4100.6 4108.6 4112.8 3905.9 4023.1 4086.4 4096.9 4102.4 3567.9 3573.6 3574.4 3579.8 3590.5 5113.1 5143.6 5145.6 5147.6 5148.3 4735.6 4741.1 4748.5 4750.7 4751.8 5593.6 5635.1 5638.5 5645.5 5647.9 3929.4 3939.4 3943.2 3944.9 3955.2 5666.1 5878.6 5966.0 5985.3 5996.7 4004.4 4027.8 4041.7 4042.9 4050.5 4091.5 4094.7 4097.8 4100.7 4102.5 4713.6 4730.0 4730.7 4734.6 4739.6 5677.3 5699.1 5708.2 5715.3 5721.5 1417.4 1439.3 1443.3 1445.1 1445.9 882.8 921.0 942.7 948.7 975.5 4891.1 5012.3 5025.6 5029.2 5037.8 5887.8 5904.7 5907.1 5915.3 5919.5 5004.4 5006.9 5012.0 5013.4 5021.8 3140.0 3171.9 3177.7 3177.8 3178.4 5538.4 5550.8 5558.6 5569.2 5570.4 5831.4 6055.3 6061.1 6076.2 6082.1 5522.6 5531.1 5535.9 5557.2 5557.4 5891.7 5892.7 5896.0 5904.5 5907.9 5793.4 5800.6 5806.5 5816.7 5828.9 5557.9 5559.8 5560.1 5560.5 5562.8 3933.1 4041.5 4044.6 4049.2 4054.2 5830.3 5837.4 5869.3 5875.9 5878.3 5661.0 5665.2 5667.1 5675.7 5676.2 5655.5 5659.0 5659.6 5665.4 5669.7 5427.6 5530.9 5571.6 5588.8 5595.2 5731.7 5749.0 5752.1 5753.5 5754.7 5596.7 5600.5 5602.3 5608.3 5613.4 22:33:01 INFO - PROCESS | 5526 | 22:33:01 INFO - PROCESS | 5526 | [#5] yui.html Cycles:180 Average:12232.98 Median:636.08 stddev:13829.88 (2174.2%) stddev-sans-first:13841.47 22:33:01 INFO - PROCESS | 5526 | Values: 679.6 695.8 754.4 775.9 782.7 13673.5 13704.2 13714.9 13778.4 13783.3 13881.7 13897.3 13925.9 13945.4 14000.9 652.6 818.8 824.9 834.6 834.6 836.2 839.6 841.8 844.1 844.3 869.0 880.2 880.7 880.9 880.9 673.7 856.6 866.5 873.9 875.3 635.9 636.3 636.4 636.5 636.5 13349.5 13450.7 13551.2 13569.7 13601.0 11574.0 11779.8 12018.2 12048.5 12275.3 9215.4 9410.1 9450.4 9485.9 9568.9 3314.6 3329.9 3367.7 3415.1 3455.0 43476.3 43791.3 43856.3 43966.0 43984.8 9688.0 9753.6 9826.7 9827.0 9870.4 15920.3 15968.5 16313.0 16365.0 16387.8 6367.1 6562.6 6642.2 6661.3 6724.4 3716.1 3731.1 3747.4 3761.6 3852.7 2755.9 2768.0 2778.2 2781.7 2781.9 492.4 498.9 505.1 507.6 515.2 502.1 522.4 623.0 630.5 633.7 7811.6 7815.4 7981.8 8078.4 8139.3 469.1 487.3 537.9 569.0 632.6 3611.3 3636.3 3643.2 3729.5 3821.7 47508.8 47828.3 48277.3 48413.5 48911.0 43170.8 44027.6 44165.0 44353.1 44741.0 38117.0 40136.8 40219.0 40660.0 40788.8 7036.0 7048.8 7049.8 7194.4 7197.4 30076.7 30151.7 30898.4 31152.4 31906.7 36729.3 39662.0 39765.0 40096.8 40132.8 9067.9 9148.5 9179.1 9205.4 9227.4 9723.3 9918.8 9922.9 9926.8 9948.4 9256.4 9284.0 9284.7 9300.2 9307.7 9729.7 9783.5 9803.2 9816.2 9844.0 9367.9 9396.6 9449.0 9471.8 9484.8 8106.3 8185.5 8344.2 8393.8 8418.1 7960.5 8127.4 8193.3 8344.2 8461.2 22:33:01 INFO - PROCESS | 5526 | -------- Summary: end -------- 22:33:01 INFO - PROCESS | 5526 | 22:33:02 INFO - TEST-INFO | 5526: exit 0 22:33:02 INFO - TEST-OK | dromaeo_css | took 1115703ms 22:33:02 INFO - TEST-START | kraken 22:33:02 INFO - operating with platform_type : linux_ 22:33:02 INFO - Initialising browser for kraken test... 22:33:02 INFO - TEST-INFO | started process 5704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnoCllJ/profile http://localhost:48774/getInfo.html) 22:33:06 INFO - PROCESS | 5704 | __metrics Screen width/height:1600/1200 22:33:06 INFO - PROCESS | 5704 | colorDepth:24 22:33:06 INFO - PROCESS | 5704 | Browser inner width/height: 1024/697 22:33:06 INFO - PROCESS | 5704 | __metrics 22:33:07 ERROR - PROCESS | 5704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:33:08 INFO - TEST-INFO | 5704: exit 0 22:33:08 INFO - Browser initialized. 22:33:08 INFO - Running cycle 1/1 for kraken test... 22:33:08 INFO - TEST-INFO | started process 5783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnoCllJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:20 INFO - PROCESS | 5783 | RSS: Main: 154181632 22:33:20 INFO - PROCESS | 5783 | 22:33:22 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-beat-detection) 22:33:23 INFO - PROCESS | 5783 | RSS: Main: 195022848 22:33:23 INFO - PROCESS | 5783 | 22:33:26 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-dft) 22:33:26 INFO - PROCESS | 5783 | RSS: Main: 184909824 22:33:26 INFO - PROCESS | 5783 | 22:33:29 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-fft) 22:33:30 INFO - PROCESS | 5783 | RSS: Main: 171454464 22:33:30 INFO - PROCESS | 5783 | 22:33:32 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48774/tests/kraken/driver.html?testName=audio-oscillator) 22:33:33 INFO - PROCESS | 5783 | RSS: Main: 172023808 22:33:33 INFO - PROCESS | 5783 | 22:33:35 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:36 INFO - PROCESS | 5783 | RSS: Main: 173150208 22:33:36 INFO - PROCESS | 5783 | 22:33:39 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48774/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:39 INFO - PROCESS | 5783 | RSS: Main: 173555712 22:33:39 INFO - PROCESS | 5783 | 22:33:43 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48774/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:43 INFO - PROCESS | 5783 | RSS: Main: 173948928 22:33:43 INFO - PROCESS | 5783 | 22:33:46 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48774/tests/kraken/driver.html?testName=json-parse-financial) 22:33:47 INFO - PROCESS | 5783 | RSS: Main: 174874624 22:33:47 INFO - PROCESS | 5783 | 22:33:48 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:49 INFO - PROCESS | 5783 | RSS: Main: 182759424 22:33:49 INFO - PROCESS | 5783 | 22:33:51 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:51 INFO - PROCESS | 5783 | RSS: Main: 182702080 22:33:51 INFO - PROCESS | 5783 | 22:33:54 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:54 INFO - PROCESS | 5783 | RSS: Main: 192233472 22:33:54 INFO - PROCESS | 5783 | 22:33:57 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:57 INFO - PROCESS | 5783 | RSS: Main: 200536064 22:33:57 INFO - PROCESS | 5783 | 22:34:00 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:34:00 INFO - PROCESS | 5783 | RSS: Main: 199553024 22:34:00 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | Cycle 1(1): loaded http://localhost:48774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48774/tests/kraken/driver.html?testName=ai-astar) 22:34:02 INFO - PROCESS | 5783 | RSS: Main: 262213632 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | __start_tp_report 22:34:02 INFO - PROCESS | 5783 | _x_x_mozilla_page_load 22:34:02 INFO - PROCESS | 5783 | _x_x_mozilla_page_load_details 22:34:02 INFO - PROCESS | 5783 | |i|pagename|runs| 22:34:02 INFO - PROCESS | 5783 | |0;ai-astar;112;112;107;111;112;113;102;112;113;113 22:34:02 INFO - PROCESS | 5783 | |1;audio-beat-detection;164;132;162;170;134;168;156;139;172;140 22:34:02 INFO - PROCESS | 5783 | |2;audio-dft;159;160;160;159;159;160;161;160;161;160 22:34:02 INFO - PROCESS | 5783 | |3;audio-fft;76;74;114;96;74;75;73;107;93;74 22:34:02 INFO - PROCESS | 5783 | |4;audio-oscillator;94;95;140;94;95;94;137;94;92;141 22:34:02 INFO - PROCESS | 5783 | |5;imaging-gaussian-blur;116;118;117;117;117;117;116;117;116;117 22:34:02 INFO - PROCESS | 5783 | |6;imaging-darkroom;147;147;147;147;145;146;145;146;145;146 22:34:02 INFO - PROCESS | 5783 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 22:34:02 INFO - PROCESS | 5783 | |8;json-parse-financial;66;66;69;66;70;65;66;76;64;65 22:34:02 INFO - PROCESS | 5783 | |9;json-stringify-tinderbox;63;64;65;64;64;67;65;64;66;65 22:34:02 INFO - PROCESS | 5783 | |10;stanford-crypto-aes;80;81;82;82;82;81;89;82;91;82 22:34:02 INFO - PROCESS | 5783 | |11;stanford-crypto-ccm;118;115;126;127;116;117;124;129;127;120 22:34:02 INFO - PROCESS | 5783 | |12;stanford-crypto-pbkdf2;139;151;140;140;129;131;138;128;126;139 22:34:02 INFO - PROCESS | 5783 | |13;stanford-crypto-sha256-iterative;66;67;69;68;66;67;66;66;68;65 22:34:02 INFO - PROCESS | 5783 | __end_tp_report 22:34:02 INFO - PROCESS | 5783 | __start_cc_report 22:34:02 INFO - PROCESS | 5783 | _x_x_mozilla_cycle_collect,1191 22:34:02 INFO - PROCESS | 5783 | __end_cc_report 22:34:02 INFO - PROCESS | 5783 | __startTimestamp1459834442973__endTimestamp 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | ------- Summary: start ------- 22:34:02 INFO - PROCESS | 5783 | Number of tests: 14 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.53 (3.2%) stddev-sans-first:3.71 22:34:02 INFO - PROCESS | 5783 | Values: 112.0 112.0 107.0 111.0 112.0 113.0 102.0 112.0 113.0 113.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:163.00 stddev:15.80 (9.7%) stddev-sans-first:16.32 22:34:02 INFO - PROCESS | 5783 | Values: 164.0 132.0 162.0 170.0 134.0 168.0 156.0 139.0 172.0 140.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 22:34:02 INFO - PROCESS | 5783 | Values: 159.0 160.0 160.0 159.0 159.0 160.0 161.0 160.0 161.0 160.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#3] audio-fft Cycles:10 Average:85.60 Median:74.50 stddev:15.61 (21.0%) stddev-sans-first:16.17 22:34:02 INFO - PROCESS | 5783 | Values: 76.0 74.0 114.0 96.0 74.0 75.0 73.0 107.0 93.0 74.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:94.00 stddev:21.94 (23.3%) stddev-sans-first:22.71 22:34:02 INFO - PROCESS | 5783 | Values: 94.0 95.0 140.0 94.0 95.0 94.0 137.0 94.0 92.0 141.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 22:34:02 INFO - PROCESS | 5783 | Values: 116.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 22:34:02 INFO - PROCESS | 5783 | Values: 147.0 147.0 147.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:34:02 INFO - PROCESS | 5783 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:66.00 stddev:3.56 (5.4%) stddev-sans-first:3.75 22:34:02 INFO - PROCESS | 5783 | Values: 66.0 66.0 69.0 66.0 70.0 65.0 66.0 76.0 64.0 65.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.05 22:34:02 INFO - PROCESS | 5783 | Values: 63.0 64.0 65.0 64.0 64.0 67.0 65.0 64.0 66.0 65.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.00 stddev:3.68 (4.5%) stddev-sans-first:3.71 22:34:02 INFO - PROCESS | 5783 | Values: 80.0 81.0 82.0 82.0 82.0 81.0 89.0 82.0 91.0 82.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:125.00 stddev:5.26 (4.2%) stddev-sans-first:5.39 22:34:02 INFO - PROCESS | 5783 | Values: 118.0 115.0 126.0 127.0 116.0 117.0 124.0 129.0 127.0 120.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:139.00 stddev:7.58 (5.5%) stddev-sans-first:7.97 22:34:02 INFO - PROCESS | 5783 | Values: 139.0 151.0 140.0 140.0 129.0 131.0 138.0 128.0 126.0 139.0 22:34:02 INFO - PROCESS | 5783 | 22:34:02 INFO - PROCESS | 5783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 22:34:02 INFO - PROCESS | 5783 | Values: 66.0 67.0 69.0 68.0 66.0 67.0 66.0 66.0 68.0 65.0 22:34:02 INFO - PROCESS | 5783 | -------- Summary: end -------- 22:34:02 INFO - PROCESS | 5783 | 22:34:03 INFO - TEST-INFO | 5783: exit 0 22:34:03 INFO - TEST-OK | kraken | took 61691ms 22:34:03 INFO - SUITE-END | took 1177s 22:34:04 INFO - Completed test suite (00:19:37) 22:34:04 INFO - javascript benchmark 22:34:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.777573906218, 2688.1129227354977, 2693.138195777352, 2699.1362763915545, 2729.1676038808164, 4550.317452382144, 4592.035672508773, 4618.74596897171, 4621.376114224583, 4630.00454902196, 4584.839530616429, 4609.654275929311, 4632.652551058667, 4644.5587669171455, 4723.29150627406, 4266.44536210293, 4275.935860962072, 4289.378040184171, 4319.0498090420215, 4436.534163912775, 4358.891027724317, 4382.583654552813, 4398.098389830077, 4409.316555933835, 4438.090191510732, 4222.598853108965, 4282.5503322151035, 4297.527272000078, 4355.0, 4361.890952726176, 4219.852305169305, 4249.043965107857, 4254.191703576311, 4282.593153650399, 4311.116221174651, 4163.3130533462245, 4256.170046840867, 4261.701680882339, 4266.91466170678, 4301.741895486281, 4512.909741805145, 4515.322701594754, 4529.230030894756, 4611.354410382549, 4627.329037289608, 4943.6539442239055, 4951.455339912607, 4955.405351357824, 4963.156263435225, 4972.502749725035, 4960.280759289919, 4975.552200301954, 4977.054359671687, 4981.576565991895, 5037.647364684473, 4511.278195488706, 4595.931061034087, 4610.953890461086, 4687.67186296956, 4690.882727931761, 4998.5751211146735, 5027.271045698353, 5038.571721403649, 5041.243813427942, 5070.771815268322, 4809.711417314972, 4813.975930120397, 4816.783244753994, 4827.686200396963, 4872.561469467765, 4811.422629284439, 4911.901761964812, 4966.180580204298, 4982.252662100642, 4993.6005119590345, 4826.758662066883, 4843.39457567804, 4856.3201151838775, 4865.245886887538, 4889.291052797395, 4844.757762111951, 4844.806207751651, 4847.95152048475, 4849.321095046696, 4897.265410188429, 4091.488563929509, 4151.771652559078, 4156.293430116887, 4160.687948403882, 4161.0221597924465, 3616.65641764032, 3655.5978842327854, 3670.889873303805, 3672.3022625701033, 3675.246574452231, 4214.093969796509, 4218.156368726267, 4220.746755194698, 4262.978685106555, 4322.848700295474, 4991.176455884811, 4992.226204938241, 4999.075171093359, 5000.374953130859, 5030.220315851049, 4307.1601037797955, 4307.719998200107, 4317.050248945227, 4343.782810859444, 4355.73865568067, 4384.583464570861, 4450.06548624786, 4489.7979590918485, 4531.932021019687, 4533.229351010336, 4659.301104834234, 4668.11305851887, 4669.369635099218, 4670.392848929618, 4716.268978308436, 4885.633577481632, 4933.889874778146, 4934.111859865258, 4938.037082768969, 4989.650724449254, 4563.49801521839, 4664.953350466452, 4701.506341834195, 4735.857924262277, 4751.073540659539, 4828.637852161031, 4842.95157048425, 4851.442084160367, 4852.344933434082, 4895.290182923527, 4791.305260737243, 4903.117438861039, 4908.656394052382, 4910.582600478856, 4956.752162391938, 4791.0, 4820.8794780130775, 4822.734749588806, 4828.589569886599, 4874.341963834837, 4729.077829823152, 4759.5240475953515, 4760.857174284777, 4770.0936822003705, 4811.951880481291, 4618.445786505641, 4696.718196908197, 4728.0780247851335, 4728.881777955578, 4773.570378665937, 4864.878378040436, 4881.365422495053, 4884.78018489176, 4886.95113048865, 4934.383202099738, 4752.0, 4756.215224488059, 4765.9046819064115, 4767.141914455431, 4796.8081276748535], "unit": "score", "name": "dojo.html", "value": 4546.820893212425}, {"lowerIsBetter": false, "replicates": [498.17551951520244, 519.5220397234544, 529.6239669834417, 537.9623426360154, 551.5477308606942, 27850.164495065153, 28421.0, 36321.45517817235, 36699.4495082574, 36753.81623091888, 39374.8031259844, 40165.7991710041, 40180.39729404061, 40216.79891600545, 40217.195656086864, 7750.92249077509, 7961.283484486395, 7963.124056353797, 7963.8805417918775, 7967.840643187162, 7869.606519674022, 8037.598120094001, 8038.8794168087525, 8040.396970227227, 8041.55771432571, 8001.079875814268, 8053.758387248363, 8056.274935255826, 8070.959645201795, 8076.152004039579, 7969.641366138509, 8004.559749213791, 8045.275925166763, 8051.718189863356, 8056.798580035487, 7933.484323518953, 8082.43422960393, 8087.676492940275, 8092.231238032377, 8093.352531797442, 38442.80778596089, 38764.0, 38791.22417551661, 39023.804880975695, 39041.60958390408, 3107.6736942620923, 3173.698498642625, 3270.8364581770816, 3374.156460884779, 3530.5586801649793, 26046.73953260462, 26266.080687175858, 26340.473190536275, 26354.20937371882, 26364.077257296096, 3387.627360990289, 3501.229729459515, 3616.692581130607, 3631.092226943264, 3696.667299943018, 179397.0, 181028.0, 181154.09422952932, 181475.0, 181659.0, 60734.39265607376, 60917.39082609206, 61394.69302653458, 61406.0, 61417.38582614206, 65584.67207664027, 65642.67178664172, 65692.0, 65892.0, 65917.0, 16285.267162977694, 16414.343426263054, 16501.83498165027, 16544.6691066178, 16557.25492352847, 12365.38173091342, 12534.68663283407, 12537.310447925269, 12538.81191782124, 12542.498300067895, 19588.608227835364, 20647.17411303561, 21106.15575376968, 21117.57764844725, 21133.0, 5652.406497317805, 7222.313880181479, 7375.668094935741, 7482.214367491444, 7720.42096842739, 898.6630013744846, 900.9144131307515, 1016.9288149829441, 1028.881678606955, 1034.343192073039, 26579.601305980425, 27244.0, 27318.453630927666, 27338.863305683346, 27441.039563615177, 989.5151375825793, 1031.0926384781494, 1048.119579553179, 1050.6375300521308, 1117.8323251512174, 14244.786328205086, 14268.126805730797, 14282.21447820359, 14543.27283635814, 14653.633659158393, 283735.0, 286146.0, 288119.0, 289417.0, 289968.0, 48656.0, 49745.0, 49778.50221497739, 49784.50215497871, 49821.0, 1042.9791404171874, 1226.9631911042504, 1230.2864338683542, 1237.5297386992886, 1270.5489551209187, 24464.143754968492, 25618.61572076383, 25743.871280643478, 25746.871265644302, 25860.482790344464, 36587.268254634226, 36769.0, 36986.44520332143, 37018.629813702595, 37023.62976370202, 170905.0, 171860.1406993007, 171927.28072719113, 172409.0, 172577.0, 32999.845005425654, 33214.66785332116, 33445.83277083599, 33719.4942075874, 34045.319093617494, 42176.15647686968, 42200.78899605482, 42224.0, 42528.0, 43271.783641081594, 35157.47263791096, 35740.82129589335, 36255.45616815802, 36357.27285454329, 36414.63585364113, 35474.467882982295, 35699.28601427905, 35716.0, 35824.596663316945, 35928.64071359253, 35762.64237357593, 35825.0, 36110.819445902605, 36147.0, 36521.269574608894, 31310.0, 32311.0, 32361.51457728089, 32395.676043239266, 32480.675193247764, 25337.366565836, 25496.617550737126, 25523.87238063872, 25529.617055743805, 25849.353766155244], "unit": "score", "name": "ext.html", "value": 17295.448433818092}, {"lowerIsBetter": false, "replicates": [349.0418800392921, 351.5254406551156, 352.7195879275977, 364.10793555788325, 366.3058504134665, 15616.687666246668, 15938.920305398471, 16984.915075424637, 17494.65010699785, 17502.299908003664, 16306.673866522662, 16717.498475045737, 16751.413700520483, 16802.0, 16847.157642117905, 4954.232094025432, 5021.447640759514, 5138.871528211787, 5145.794168233285, 5154.32993710817, 5145.794168233266, 5165.845024649267, 5186.611004174683, 5187.092258854705, 5210.036143313499, 5048.368953880765, 5068.366454193226, 5081.46644602317, 5116.897662046776, 5121.641485096045, 4999.925001124986, 5062.7468626568525, 5116.974415127937, 5128.076946149691, 5135.204043373283, 4564.8402305919135, 4571.291449825249, 4572.0627271409285, 4572.5427457254345, 4574.0, 18199.090045497804, 19377.321793737294, 20320.390388288375, 20335.4916127098, 20338.389848304574, 1988.721578978944, 2208.8122509586706, 2328.930132096023, 2390.5457962986975, 2447.5716749568755, 8936.553172341422, 9097.181253687133, 9329.906700932972, 9347.672831450935, 9399.060093990614, 1734.6964281250857, 1817.4365946556609, 1822.8541716662635, 1833.6424397242542, 1850.9629807403776, 60946.390536094514, 64496.677516612115, 64926.3507364925, 64996.675016625086, 66002.66998664977, 9632.9036709632, 9841.32343011477, 9856.063673950963, 10026.398416095057, 10058.094771470604, 13365.732685346238, 13370.665733356744, 13421.66445838862, 13431.328433578283, 13441.529546465827, 7274.381677557361, 7283.781486555412, 7417.962910185523, 7539.962300188464, 7556.848863022708, 7155.17715462718, 7165.0685410897295, 7196.46026548011, 7292.416606671453, 7314.08573928259, 4278.465191851019, 4318.093200427883, 4324.978375108104, 4347.282698354736, 4389.31965545341, 1774.1661419132986, 1785.2055835153233, 1825.771778527684, 1849.6485667723089, 1852.3424184414607, 839.1482645115213, 872.1148034744739, 904.5296445848122, 909.6543313540813, 913.1097180249204, 15661.765073523906, 15898.0, 16095.919520402324, 16225.59436014109, 16314.428994985119, 870.0994470722771, 876.7369789063383, 893.5576889439769, 907.6006557114848, 939.5302348825587, 8833.823323533494, 9201.0, 9261.008883090168, 9400.905990940004, 9516.476593787409, 315054.0, 318354.0, 318900.0, 382564.0, 424659.0, 55026.724866375414, 64717.0, 69016.30983690098, 71960.0, 72026.0, 439.86364227089706, 451.46726862302796, 453.8956040110793, 457.4487742270556, 457.58131309851115, 8627.611757471055, 9695.854562181432, 10078.244131690006, 10306.896931030593, 10642.680719578426, 32199.35601288008, 32274.35451291008, 32892.67107328896, 33342.83328583342, 34590.82704586461, 39886.40170397388, 41967.58032419759, 42686.78656606697, 42833.785831071895, 43305.350419743096, 7658.2724641159, 7675.155732869492, 7752.5348479091435, 7964.9203507966495, 8015.599220039091, 11375.374354410256, 11625.302481851117, 11918.582849600223, 11935.582254621047, 12110.576129835414, 10251.128654064489, 10378.325408848401, 10433.478326083818, 10541.736456588647, 10730.141588672732, 10159.796804064024, 10447.373157610567, 10478.738031548968, 10497.475126243504, 10527.894721052999, 10417.114545263737, 10459.215558832966, 10483.52824122901, 10492.422916739348, 10719.14246860265, 7676.0, 7699.769006929801, 7741.7677469676, 7828.060632724109, 7896.289333959971, 9579.185769209416, 10225.279106858232, 10425.165986720893, 10503.159747220358, 10597.523111459848], "unit": "score", "name": "jquery.html", "value": 7784.762480122626}, {"lowerIsBetter": false, "replicates": [1387.2439520461348, 1407.6340151560594, 1519.817621885374, 1686.603648142687, 1732.4282986614419, 6775.1531058617675, 6816.659167041653, 6975.651217439133, 6987.021816945632, 6988.405985491239, 6058.545609079326, 6184.165137706408, 6668.76659316924, 6805.795826125224, 6866.862662746755, 2164.318239754476, 2196.6375548034557, 2198.329509499602, 2198.5163264081875, 2200.4388880835445, 2118.0998075817793, 2141.550274442369, 2165.577712346093, 2166.9783302166934, 2167.2414654870827, 1786.740922566227, 2107.357256036908, 2139.2833400810746, 2159.222679835258, 2160.9135634574677, 2069.213698794456, 2076.397844625057, 2107.673310636854, 2108.399106254718, 2110.8311335093154, 2084.0, 2119.5337025854287, 2120.257909731597, 2121.31057406342, 2123.214410668047, 6853.520253582202, 6893.069435626227, 6895.793126206222, 6909.481788865855, 6924.649693309807, 4318.632916202127, 4427.158839820424, 4433.290673492225, 4446.021875187454, 4451.732896026248, 2841.602175695404, 2875.051233093074, 2943.0, 2954.822710637347, 2970.643522777259, 923.9584218710174, 967.4727273635885, 968.0, 986.2110311750642, 986.8914419413859, 8792.252658523968, 9357.906420935771, 9371.812563748686, 9396.295277854188, 9397.718068457958, 3930.8231129599235, 4042.0, 4045.7572545647354, 4084.4077608746566, 4104.610062044101, 8128.227818357246, 8155.5514446706, 8162.30620397261, 8163.387745918961, 8180.386471014579, 4436.64506839452, 4450.198964186413, 4452.799624016927, 4454.131444368382, 4455.754933478625, 3387.2209391840015, 3872.786996715208, 3944.9211015780097, 4020.1758639478835, 4022.1553473770837, 3427.537282466885, 3436.742244331685, 3486.4770284457027, 3516.4197907345, 3518.296340731864, 1138.0440430038807, 1144.8511693479795, 1152.8558930133734, 1158.478684591937, 1159.3449700919123, 1192.4455128365353, 1193.7910865598485, 1201.3212534917743, 1216.2520050169082, 1216.6289281768968, 6533.575317604341, 6676.9666151668935, 6685.431738302299, 6721.22705888829, 6726.3609957054005, 470.6916969385058, 472.480271701126, 473.79863557987716, 484.70433035848106, 486.6860874735776, 4987.650864439454, 5065.797368105308, 5070.670406423571, 5119.360079990001, 5123.410807757081, 8217.301529369952, 8294.58527073656, 8516.190961858614, 8531.957340213383, 8648.69729559475, 8429.283510901641, 8481.618327175293, 8519.872201916976, 8576.399652024298, 8582.742517724479, 6638.601683898885, 6703.29615390377, 6750.426213771884, 6763.222229443677, 6832.555883867532, 6398.296187419473, 6471.158749362553, 6482.513811464065, 6486.967565162144, 6491.448226900767, 7373.29953654402, 7551.509151905108, 7623.352015078781, 7654.540727556365, 7756.457048006811, 7748.728794492165, 7882.448228623941, 7884.0144981877265, 7955.840883182188, 7992.120866704774, 5471.206675032177, 5890.617109888015, 6130.2030736004035, 6319.968400158154, 6382.0, 6638.83402914931, 6651.767188148391, 6655.733770649314, 6691.029800678972, 6703.262641109572, 6002.8499287516415, 6091.269047714302, 6168.982117950488, 6212.534059945432, 6218.378162183745, 5967.104934259895, 6009.128676341818, 6022.698865056817, 6106.9083963739695, 6110.388961104032, 6320.273168585672, 6447.290798012309, 6448.871022579616, 6451.774187903401, 6454.774082907075, 5865.501432378295, 5962.880742385041, 5965.731542080704, 5965.791197308247, 5968.239369385955, 6029.457348838626, 6043.214382130295, 6063.333033366238, 6096.390360963868, 6117.694115294128], "unit": "score", "name": "mootools.html", "value": 4041.830610059001}, {"lowerIsBetter": false, "replicates": [309.81565968248884, 316.58053079669435, 322.2941757550965, 322.4341281051754, 323.90282915125454, 5286.259923610698, 5413.43158968308, 5428.294321738178, 5437.8368648940495, 5438.510534051935, 5232.529072383485, 5393.352797664276, 5417.10617748072, 5423.83728488146, 5438.238646589471, 3945.4279129526203, 4027.234825383168, 4101.364288535282, 4156.480439945014, 4158.9376159357635, 4094.97952510237, 4124.463819703449, 4127.360259159835, 4132.318167502359, 4145.730527515717, 4077.3883917412477, 4085.101277718897, 4100.56944020878, 4108.5686002969705, 4112.814923328442, 3905.8632947846972, 4023.054582173216, 4086.4074709167303, 4096.877093687194, 4102.446169767073, 3567.928641427183, 3573.6247693992277, 3574.3566158091794, 3579.7673151245085, 3590.4793804898404, 5113.130767769451, 5143.6399452037995, 5145.562627176694, 5147.613928955343, 5148.2535032420465, 4735.597474214662, 4741.099191153669, 4748.477667456612, 4750.738709370983, 4751.809927602892, 5593.636413633101, 5635.098384258499, 5638.548916086703, 5645.491905728504, 5647.8588035299035, 3929.390944403622, 3939.4484772131923, 3943.211357728437, 3944.9211015779524, 3955.248502784462, 5666.093425051972, 5878.588498805086, 5965.970170149165, 5985.25184351956, 5996.670183139926, 4004.3593025115842, 4027.81874815634, 4041.7372870763306, 4042.939355909664, 4050.4531888195306, 4091.5499295077516, 4094.7133700641266, 4097.774622395737, 4100.671946244293, 4102.528209255914, 4713.552212539803, 4730.030343779517, 4730.668853180245, 4734.597559207506, 4739.620830333634, 5677.3471050829685, 5699.145128230715, 5708.20085188074, 5715.257016587817, 5721.5136713379, 1417.3551034279378, 1439.2803598200899, 1443.3216388297483, 1445.0534899640752, 1445.8915581331232, 882.8101958079044, 920.9539523023822, 942.7266092833139, 948.7296120605595, 975.5268694683073, 4891.144049791273, 5012.298278241049, 5025.572826309804, 5029.245613158056, 5037.798488060436, 5887.8233652990475, 5904.704764761745, 5907.1434641976675, 5915.260592425947, 5919.467247947619, 5004.374453193351, 5006.899862002812, 5012.0, 5013.448520662724, 5021.774020169101, 3140.0422871024102, 3171.8572664230164, 3177.7298929591243, 3177.7616678749187, 3178.411993781158, 5538.446155384429, 5550.805721799798, 5558.637579028897, 5569.220309156722, 5570.41510641385, 5831.446012628879, 6055.303640081359, 6061.121137435047, 6076.240469941257, 6082.148499210114, 5522.6134170607675, 5531.0873705838085, 5535.861603459865, 5557.221988921635, 5557.360903496069, 5891.675957822361, 5892.6759028253855, 5895.9705201475435, 5904.468597826216, 5907.881842363215, 5793.420657934173, 5800.56495762811, 5806.535477161901, 5816.70916454184, 5828.94171058301, 5557.861053473695, 5559.805406810742, 5560.110382338807, 5560.527355174855, 5562.805301814579, 3933.1347103637154, 4041.4948131483566, 4044.6157615026527, 4049.1901619675596, 4054.2499637567144, 5830.329512105993, 5837.416258374129, 5869.266341707286, 5875.882482350415, 5878.265216847894, 5660.971695141498, 5665.178549110438, 5667.093265077568, 5675.687837168995, 5676.2337084493065, 5655.519280861173, 5658.971705141448, 5659.575531835211, 5665.405132461032, 5669.716514174357, 5427.592930530305, 5530.944690553204, 5571.554275657856, 5588.77644894216, 5595.160725891149, 5731.713414329351, 5748.971255143698, 5752.050911599539, 5753.510951569164, 5754.712264386848, 5596.692181930033, 5600.4959553640365, 5602.299712535933, 5608.327000759935, 5613.410591887793], "unit": "score", "name": "prototype.html", "value": 4243.7305962858345}, {"lowerIsBetter": false, "replicates": [679.6363945289271, 695.7703957693958, 754.4153281207064, 775.8564665536876, 782.7103971530532, 13673.521426750054, 13704.24626645534, 13714.931425342871, 13778.379972901219, 13783.310834458262, 13881.722365552683, 13897.305134743248, 13925.93037034816, 13945.372458239379, 14000.929995350034, 652.6475703120333, 818.758466252457, 824.9340052795762, 834.5952213176635, 834.6160766047625, 836.1596595421593, 839.5927974932154, 841.7769291137853, 844.0630899701326, 844.3456321350941, 868.9695860644879, 880.2034159086005, 880.6873559886244, 880.8810810540559, 880.8898887639045, 673.7170388436843, 856.6273670953155, 866.5234121233328, 873.9344549158839, 875.2735229759285, 635.8760041791852, 636.2937139774846, 636.3509220594967, 636.4876274598946, 636.5130675033603, 13349.466021359134, 13450.730985380336, 13551.186928784304, 13569.660758481019, 13601.0, 11574.0, 11779.823302650468, 12018.218815776947, 12048.457819398149, 12275.324857132855, 9215.400998935047, 9410.106039926197, 9450.385724927926, 9485.905140948571, 9568.856467152998, 3314.5691060162026, 3329.883454079096, 3367.696907278357, 3415.0608582639725, 3455.015320633607, 43476.3478547822, 43791.34312985308, 43856.3421548677, 43965.99999999968, 43984.780076099734, 9687.999999999858, 9753.609855605839, 9826.65606703762, 9827.0, 9870.358426702242, 15920.283587238602, 15968.520944371687, 16313.0, 16365.0, 16387.83612163887, 6367.076773867856, 6562.606243625398, 6642.202935647657, 6661.26726060133, 6724.428423583952, 3716.089558058293, 3731.1231860512758, 3747.4191500317493, 3761.6050314716563, 3852.653261206505, 2755.875985580654, 2767.958480622792, 2778.180436771117, 2781.694013658496, 2781.9428617125363, 492.4312419155881, 498.8952320012838, 505.1336957118559, 507.55382846266235, 515.222014757711, 502.0836972525156, 522.3940229333955, 622.9596573721805, 630.5145038320559, 633.6514916795744, 7811.609419529001, 7815.413843961725, 7981.840363192704, 8078.35373170145, 8139.30815880645, 469.143812542112, 487.32018833726755, 537.857467771041, 568.9630174038674, 632.6141053957083, 3611.331903597843, 3636.254567813592, 3643.1620727232353, 3729.4592284118653, 3821.7133714971487, 47508.7624561875, 47828.28257576139, 48277.275840862414, 48413.5158648409, 48911.0, 43170.84145792698, 44027.559724402985, 44165.0, 44353.11293774171, 44741.0, 38117.0, 40136.799316003235, 40218.99452513652, 40660.0, 40788.79605601953, 7036.0, 7048.823779405556, 7049.7885063448175, 7194.388476979515, 7197.388222001188, 30076.699233008265, 30151.698483015767, 30898.38203235878, 31152.37695246037, 31906.68093319037, 36729.26541469209, 39662.0, 39765.0, 40096.79951600223, 40132.79933600313, 9067.863982040142, 9148.451092934445, 9179.127982841619, 9205.355625106446, 9227.44635321883, 9723.270754693567, 9918.752031199278, 9922.900770992197, 9926.801463970536, 9948.403095814274, 9256.398334108262, 9283.953580232055, 9284.72145835626, 9300.20948219409, 9307.674231401868, 9729.659461918798, 9783.46190959504, 9803.16673082796, 9816.165625921876, 9844.0, 9367.859482107637, 9396.577154028222, 9449.0, 9471.810563788824, 9484.810303794024, 8106.270435660583, 8185.549794761345, 8344.249017588203, 8393.790155245924, 8418.116097809641, 7960.522368657899, 8127.431079824592, 8193.262606365455, 8344.249017588447, 8461.196186362286], "unit": "score", "name": "yui.html", "value": 5728.269018752615}], "name": "dromaeo_css", "value": 6259.6014183717525}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 107.0, 111.0, 112.0, 113.0, 102.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [164.0, 132.0, 162.0, 170.0, 134.0, 168.0, 156.0, 139.0, 172.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 153.7}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 159.0, 159.0, 160.0, 161.0, 160.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 114.0, 96.0, 74.0, 75.0, 73.0, 107.0, 93.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 140.0, 94.0, 95.0, 94.0, 137.0, 94.0, 92.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 69.0, 66.0, 70.0, 65.0, 66.0, 76.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 67.0, 65.0, 64.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 82.0, 82.0, 81.0, 89.0, 82.0, 91.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 126.0, 127.0, 116.0, 117.0, 124.0, 129.0, 127.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [139.0, 151.0, 140.0, 140.0, 129.0, 131.0, 138.0, 128.0, 126.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 68.0, 66.0, 67.0, 66.0, 66.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1515.5}]} 22:34:04 INFO - Return code: 0 22:34:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:34:04 ERROR - # TBPL SUCCESS # 22:34:04 INFO - Running post-action listener: _resource_record_post_action 22:34:04 INFO - Running post-run listener: _resource_record_post_run 22:34:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 519151616; Read time: 20; Write time: 480100 22:34:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239747072; Read time: 0; Write time: 250732 22:34:05 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 8192; Write bytes: 279404544; Read time: 20; Write time: 229368 22:34:05 INFO - Running post-run listener: _upload_blobber_files 22:34:05 INFO - Blob upload gear active. 22:34:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:34:05 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 22:34:05 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'] 22:34:05 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 22:34:05 INFO - (blobuploader) - INFO - Open directory for files ... 22:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:06 INFO - (blobuploader) - INFO - Done attempting. 22:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:34:07 INFO - (blobuploader) - INFO - Done attempting. 22:34:07 INFO - (blobuploader) - INFO - Iteration through files over. 22:34:07 INFO - Return code: 0 22:34:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:34:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:34:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e721f0ef02e5e3703d55fff30b096815130dc6c0eebfacf26d71c66d293ca0a5cae556bba96825dfdba41f0d0f55412937658348276653d085407c3a2ae31564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817707dad91d73529fe2b0edd197b5ca3bf3f968e43ce802f04dcd2e4bdc2a53f8603f397eb81597c878f6f0c17547e370d9c8bfe7282caa8d8929ceed4ff8d5"} 22:34:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:34:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:34:07 INFO - Contents: 22:34:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e721f0ef02e5e3703d55fff30b096815130dc6c0eebfacf26d71c66d293ca0a5cae556bba96825dfdba41f0d0f55412937658348276653d085407c3a2ae31564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817707dad91d73529fe2b0edd197b5ca3bf3f968e43ce802f04dcd2e4bdc2a53f8603f397eb81597c878f6f0c17547e370d9c8bfe7282caa8d8929ceed4ff8d5"} 22:34:07 INFO - Running post-run listener: copy_logs_to_upload_dir 22:34:07 INFO - Copying logs to upload dir... 22:34:07 INFO - mkdir: /builds/slave/test/build/upload/logs 22:34:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.417561 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-04 22:34:06.666496) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 22:34:06.674151) ========= 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e721f0ef02e5e3703d55fff30b096815130dc6c0eebfacf26d71c66d293ca0a5cae556bba96825dfdba41f0d0f55412937658348276653d085407c3a2ae31564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817707dad91d73529fe2b0edd197b5ca3bf3f968e43ce802f04dcd2e4bdc2a53f8603f397eb81597c878f6f0c17547e370d9c8bfe7282caa8d8929ceed4ff8d5"} build_url:https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/MNiQF_XkRcO3q4tf6SjS_g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e721f0ef02e5e3703d55fff30b096815130dc6c0eebfacf26d71c66d293ca0a5cae556bba96825dfdba41f0d0f55412937658348276653d085407c3a2ae31564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/817707dad91d73529fe2b0edd197b5ca3bf3f968e43ce802f04dcd2e4bdc2a53f8603f397eb81597c878f6f0c17547e370d9c8bfe7282caa8d8929ceed4ff8d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 22:34:06.704634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:34:06.705014) ========= 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=836cfdc75598d54cb747368e000001a9-1459833212.599086-1059524928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:34:06.789705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:34:06.790068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:34:06.790396) ========= ========= Total master_lag: 0.31 =========