builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1477924029.69 results: success (0) buildid: 20161031062605 builduid: 162cca04af16470992ae81ed2c552e8a revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.695360) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.695825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.696134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.711551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.711876) ========= 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=0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 07:27:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-10-31 07:27:09 (47.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.804180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.804558) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:09.854374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 07:27:09.854771) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --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=0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 07:27:09,985 truncating revision to first 12 chars 2016-10-31 07:27:09,985 Setting DEBUG logging. 2016-10-31 07:27:09,985 attempt 1/10 2016-10-31 07:27:09,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/969c3295d3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 07:27:11,212 unpacking tar archive at: fx-team-969c3295d3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.532480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 07:27:11.401309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:11.401687) ========= script_repo_revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:11.402124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:11.402463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 07:27:11.412270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-31 07:27:11.412641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:27:11 INFO - MultiFileLogger online at 20161031 07:27:11 in /builds/slave/test 07:27:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:27:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:11 INFO - {'append_to_log': False, 07:27:11 INFO - 'base_work_dir': '/builds/slave/test', 07:27:11 INFO - 'blob_upload_branch': 'Fx-Team', 07:27:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:11 INFO - 'branch': 'Fx-Team', 07:27:11 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:11 INFO - 'config_files': ('talos/linux_config.py',), 07:27:11 INFO - 'default_actions': ('clobber', 07:27:11 INFO - 'read-buildbot-config', 07:27:11 INFO - 'download-and-extract', 07:27:11 INFO - 'populate-webroot', 07:27:11 INFO - 'create-virtualenv', 07:27:11 INFO - 'install', 07:27:11 INFO - 'run-tests'), 07:27:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:11 INFO - 'download_minidump_stackwalk': True, 07:27:11 INFO - 'download_symbols': 'ondemand', 07:27:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:11 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:11 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:11 INFO - 'installer_path': 'installer.exe', 07:27:11 INFO - 'log_level': 'info', 07:27:11 INFO - 'log_name': 'talos', 07:27:11 INFO - 'log_to_console': True, 07:27:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:27:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:27:11 INFO - 'opt_config_files': (), 07:27:11 INFO - 'pip_index': False, 07:27:11 INFO - 'sps_profile': False, 07:27:11 INFO - 'sps_profile_interval': 0, 07:27:11 INFO - 'suite': 'dromaeojs', 07:27:11 INFO - 'system_bits': '32', 07:27:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:11 INFO - 'title': 'talos-linux64-ix-017', 07:27:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:11 INFO - 'use_talos_json': True, 07:27:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:11 INFO - 'work_dir': 'build'} 07:27:11 INFO - [mozharness: 2016-10-31 14:27:11.644217Z] Running clobber step. 07:27:11 INFO - Running pre-action listener: _resource_record_pre_action 07:27:11 INFO - Running main action method: clobber 07:27:11 INFO - rmtree: /builds/slave/test/build 07:27:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:12 INFO - Running post-action listener: _resource_record_post_action 07:27:12 INFO - [mozharness: 2016-10-31 14:27:12.625341Z] Finished clobber step (success) 07:27:12 INFO - [mozharness: 2016-10-31 14:27:12.625439Z] Running read-buildbot-config step. 07:27:12 INFO - Running pre-action listener: _resource_record_pre_action 07:27:12 INFO - Running main action method: read_buildbot_config 07:27:12 INFO - Using buildbot properties: 07:27:12 INFO - { 07:27:12 INFO - "project": "", 07:27:12 INFO - "product": "firefox", 07:27:12 INFO - "script_repo_revision": "production", 07:27:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:27:12 INFO - "repository": "", 07:27:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:27:12 INFO - "buildid": "20161031062605", 07:27:12 INFO - "stage_platform": "linux64-pgo", 07:27:12 INFO - "basedir": "/builds/slave/test", 07:27:12 INFO - "buildnumber": 1671, 07:27:12 INFO - "platform": "ubuntu64_hw", 07:27:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:27:12 INFO - "slavebuilddir": "test", 07:27:12 INFO - "branch": "fx-team", 07:27:12 INFO - "revision": "969c3295d3aa77931cca26eddb047d9d74bd9858", 07:27:12 INFO - "slavename": "talos-linux64-ix-017", 07:27:12 INFO - "builduid": "162cca04af16470992ae81ed2c552e8a", 07:27:12 INFO - "repo_path": "integration/fx-team" 07:27:12 INFO - } 07:27:12 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:27:12 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 07:27:12 INFO - Running post-action listener: _resource_record_post_action 07:27:12 INFO - [mozharness: 2016-10-31 14:27:12.627788Z] Finished read-buildbot-config step (success) 07:27:12 INFO - [mozharness: 2016-10-31 14:27:12.627877Z] Running download-and-extract step. 07:27:12 INFO - Running pre-action listener: _resource_record_pre_action 07:27:12 INFO - Running main action method: download_and_extract 07:27:12 INFO - mkdir: /builds/slave/test/build/tests 07:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:27:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:27:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:27:12 INFO - Downloaded 1361 bytes. 07:27:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:27:12 INFO - Using the following test package requirements: 07:27:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:27:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:27:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'jsshell-linux-x86_64.zip'], 07:27:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:27:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:27:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:27:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:27:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:27:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:27:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:27:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:27:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:27:12 INFO - Http code: 200 07:27:12 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 07:27:12 INFO - x-amz-cf-id: xmTG4IBj-DX_FUrgIT8L21zr-SkT91xDKlLhxFB7aY6gupuXB3o9Dw== 07:27:12 INFO - x-amz-replication-status: PENDING 07:27:12 INFO - x-amz-version-id: xZjt3Y8X.FbPmwGIU3XMiuDkZpRR4hmc 07:27:13 INFO - Expected file size: 22006276 07:27:13 INFO - Obtained file size: 22006276 07:27:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:27:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:27:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:27:17 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:27:17 INFO - Http code: 200 07:27:17 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 07:27:17 INFO - x-amz-cf-id: coxe7EHfR6JxN0cBtNCh2nyM2gurboyfhyGNhTPpd-lyX2MxlLrObQ== 07:27:17 INFO - x-amz-replication-status: PENDING 07:27:17 INFO - x-amz-version-id: xZjt3Y8X.FbPmwGIU3XMiuDkZpRR4hmc 07:27:17 INFO - Expected file size: 22006276 07:27:17 INFO - Obtained file size: 22006276 07:27:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:27:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:27:21 INFO - Http code: 200 07:27:21 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 07:27:21 INFO - x-amz-cf-id: DFo_iySRDjq6lWb3nJQYtScH_53fpD8bRaQ7CMUUs7vtvPXU_0d1GQ== 07:27:21 INFO - x-amz-replication-status: PENDING 07:27:21 INFO - x-amz-version-id: AqeKqJcTmfzkr1EggL_4tmHoXsRxNmP9 07:27:22 INFO - Expected file size: 14409038 07:27:22 INFO - Obtained file size: 14409038 07:27:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:22 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:27:22 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:27:23 INFO - Downloaded 59633840 bytes. 07:27:23 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:27:23 INFO - mkdir: /builds/slave/test/properties 07:27:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:23 INFO - Contents: 07:27:23 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:27:23 INFO - Running post-action listener: _resource_record_post_action 07:27:23 INFO - Running post-action listener: set_extra_try_arguments 07:27:23 INFO - [mozharness: 2016-10-31 14:27:23.453467Z] Finished download-and-extract step (success) 07:27:23 INFO - [mozharness: 2016-10-31 14:27:23.453694Z] Running populate-webroot step. 07:27:23 INFO - Running pre-action listener: _resource_record_pre_action 07:27:23 INFO - Running main action method: populate_webroot 07:27:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:23 INFO - '--tppagecycles', 07:27:23 INFO - '7'], 07:27:23 INFO - 'tests': ['tsvgm']}}, 07:27:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['damp', 'tps']}, 07:27:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'tests': ['damp', 'tps']}, 07:27:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['dromaeo_dom']}, 07:27:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['basic_compositor_video']}, 07:27:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:27:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['a11yr', 07:27:23 INFO - 'ts_paint', 07:27:23 INFO - 'tpaint', 07:27:23 INFO - 'sessionrestore', 07:27:23 INFO - 'sessionrestore_no_auto_restore', 07:27:23 INFO - 'tabpaint']}, 07:27:23 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:23 INFO - 'ts_paint', 07:27:23 INFO - 'tpaint', 07:27:23 INFO - 'sessionrestore', 07:27:23 INFO - 'sessionrestore_no_auto_restore', 07:27:23 INFO - 'tabpaint']}, 07:27:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:23 INFO - 'ts_paint', 07:27:23 INFO - 'tpaint', 07:27:23 INFO - 'sessionrestore', 07:27:23 INFO - 'sessionrestore_no_auto_restore', 07:27:23 INFO - 'tabpaint']}, 07:27:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:23 INFO - 'ts_paint', 07:27:23 INFO - 'tpaint', 07:27:23 INFO - 'sessionrestore', 07:27:23 INFO - 'sessionrestore_no_auto_restore', 07:27:23 INFO - 'tabpaint']}, 07:27:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['a11yr', 07:27:23 INFO - 'ts_paint', 07:27:23 INFO - 'tpaint', 07:27:23 INFO - 'sessionrestore', 07:27:23 INFO - 'sessionrestore_no_auto_restore', 07:27:23 INFO - 'tabpaint']}, 07:27:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['a11yr', 07:27:23 INFO - 'ts_paint', 07:27:23 INFO - 'tpaint', 07:27:23 INFO - 'sessionrestore', 07:27:23 INFO - 'sessionrestore_no_auto_restore', 07:27:23 INFO - 'tabpaint']}, 07:27:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['tsvgx', 07:27:23 INFO - 'tsvgr_opacity', 07:27:23 INFO - 'tart', 07:27:23 INFO - 'tscrollx', 07:27:23 INFO - 'cart']}, 07:27:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:23 INFO - 'tsvgr_opacity', 07:27:23 INFO - 'tart', 07:27:23 INFO - 'tscrollx', 07:27:23 INFO - 'cart']}, 07:27:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'talos_options': ['--disable-e10s'], 07:27:23 INFO - 'tests': ['tp5o']}, 07:27:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'tests': ['tp5o']}, 07:27:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'talos_options': ['--disable-e10s', 07:27:23 INFO - '--xperf_path', 07:27:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:23 INFO - 'tests': ['tp5n']}, 07:27:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:23 INFO - 'talos_options': ['--xperf_path', 07:27:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:23 INFO - 'tests': ['tp5n']}}, 07:27:23 INFO - 'talos.zip': {'path': '', 07:27:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:23 INFO - Running post-action listener: _resource_record_post_action 07:27:23 INFO - [mozharness: 2016-10-31 14:27:23.471426Z] Finished populate-webroot step (success) 07:27:23 INFO - [mozharness: 2016-10-31 14:27:23.471515Z] Running create-virtualenv step. 07:27:23 INFO - Running pre-action listener: _resource_record_pre_action 07:27:23 INFO - Running main action method: create_virtualenv 07:27:23 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:23 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 07:27:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:23 INFO - Using real prefix '/usr' 07:27:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:24 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:26 INFO - Installing pip.................done. 07:27:26 INFO - Return code: 0 07:27:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:27:26 INFO - Reading from file tmpfile_stdout 07:27:26 INFO - Output received: 07:27:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:27:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:26 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 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:26 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 07:27:26 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 07:27:26 INFO - Using env: {'DISPLAY': ':0', 07:27:26 INFO - 'HOME': '/home/cltbld', 07:27:26 INFO - 'LANG': 'en_US.UTF-8', 07:27:26 INFO - 'LANGUAGE': 'en_US:en', 07:27:26 INFO - 'LOGNAME': 'cltbld', 07:27:26 INFO - 'MAIL': '/var/mail/cltbld', 07:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:26 INFO - 'MOZ_NO_REMOTE': '1', 07:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:26 INFO - 'NO_EM_RESTART': '1', 07:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:26 INFO - 'PWD': '/builds/slave/test', 07:27:26 INFO - 'SHELL': '/bin/bash', 07:27:26 INFO - 'SHLVL': '1', 07:27:26 INFO - 'TERM': 'linux', 07:27:26 INFO - 'TMOUT': '86400', 07:27:26 INFO - 'USER': 'cltbld', 07:27:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:26 INFO - '_': '/tools/buildbot/bin/python'} 07:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:26 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 07:27:26 INFO - Cleaning up... 07:27:26 INFO - Return code: 0 07:27:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:27:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:26 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:26 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>=3.1.1'] in /builds/slave/test/build 07:27:26 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>=3.1.1 07:27:26 INFO - Using env: {'DISPLAY': ':0', 07:27:26 INFO - 'HOME': '/home/cltbld', 07:27:26 INFO - 'LANG': 'en_US.UTF-8', 07:27:26 INFO - 'LANGUAGE': 'en_US:en', 07:27:26 INFO - 'LOGNAME': 'cltbld', 07:27:26 INFO - 'MAIL': '/var/mail/cltbld', 07:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:26 INFO - 'MOZ_NO_REMOTE': '1', 07:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:26 INFO - 'NO_EM_RESTART': '1', 07:27:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:26 INFO - 'PWD': '/builds/slave/test', 07:27:26 INFO - 'SHELL': '/bin/bash', 07:27:26 INFO - 'SHLVL': '1', 07:27:26 INFO - 'TERM': 'linux', 07:27:26 INFO - 'TMOUT': '86400', 07:27:26 INFO - 'USER': 'cltbld', 07:27:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:26 INFO - '_': '/tools/buildbot/bin/python'} 07:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:26 INFO - Downloading/unpacking psutil>=3.1.1 07:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:28 INFO - Installing collected packages: psutil 07:27:28 INFO - Running setup.py install for psutil 07:27:28 INFO - building 'psutil._psutil_linux' extension 07:27:28 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 07:27:29 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 07:27:29 INFO - building 'psutil._psutil_posix' extension 07:27:29 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 07:27:29 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 07:27:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:29 INFO - Successfully installed psutil 07:27:29 INFO - Cleaning up... 07:27:29 INFO - Return code: 0 07:27:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:27:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:29 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:29 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.3'] in /builds/slave/test/build 07:27:29 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.3 07:27:29 INFO - Using env: {'DISPLAY': ':0', 07:27:29 INFO - 'HOME': '/home/cltbld', 07:27:29 INFO - 'LANG': 'en_US.UTF-8', 07:27:29 INFO - 'LANGUAGE': 'en_US:en', 07:27:29 INFO - 'LOGNAME': 'cltbld', 07:27:29 INFO - 'MAIL': '/var/mail/cltbld', 07:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:29 INFO - 'MOZ_NO_REMOTE': '1', 07:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:29 INFO - 'NO_EM_RESTART': '1', 07:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:29 INFO - 'PWD': '/builds/slave/test', 07:27:29 INFO - 'SHELL': '/bin/bash', 07:27:29 INFO - 'SHLVL': '1', 07:27:29 INFO - 'TERM': 'linux', 07:27:29 INFO - 'TMOUT': '86400', 07:27:29 INFO - 'USER': 'cltbld', 07:27:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:29 INFO - '_': '/tools/buildbot/bin/python'} 07:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 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 07:27:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:27:31 INFO - Installing collected packages: mozsystemmonitor 07:27:31 INFO - Running setup.py install for mozsystemmonitor 07:27:31 INFO - Successfully installed mozsystemmonitor 07:27:31 INFO - Cleaning up... 07:27:31 INFO - Return code: 0 07:27:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:31 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:31 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==2.5.1'] in /builds/slave/test/build 07:27:31 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==2.5.1 07:27:31 INFO - Using env: {'DISPLAY': ':0', 07:27:31 INFO - 'HOME': '/home/cltbld', 07:27:31 INFO - 'LANG': 'en_US.UTF-8', 07:27:31 INFO - 'LANGUAGE': 'en_US:en', 07:27:31 INFO - 'LOGNAME': 'cltbld', 07:27:31 INFO - 'MAIL': '/var/mail/cltbld', 07:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:31 INFO - 'MOZ_NO_REMOTE': '1', 07:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:31 INFO - 'NO_EM_RESTART': '1', 07:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:31 INFO - 'PWD': '/builds/slave/test', 07:27:31 INFO - 'SHELL': '/bin/bash', 07:27:31 INFO - 'SHLVL': '1', 07:27:31 INFO - 'TERM': 'linux', 07:27:31 INFO - 'TMOUT': '86400', 07:27:31 INFO - 'USER': 'cltbld', 07:27:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:31 INFO - '_': '/tools/buildbot/bin/python'} 07:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:27:33 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 07:27:33 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 07:27:33 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 07:27:33 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 07:27:33 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 07:27:33 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 07:27:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:34 INFO - warning: no files found matching '*.txt' 07:27:34 INFO - no previously-included directories found matching 'build' 07:27:34 INFO - no previously-included directories found matching 'dist' 07:27:34 INFO - no previously-included directories found matching '.git*' 07:27:34 INFO - Installing collected packages: jsonschema, functools32 07:27:34 INFO - Running setup.py install for functools32 07:27:34 INFO - warning: no files found matching '*.txt' 07:27:34 INFO - no previously-included directories found matching 'build' 07:27:34 INFO - no previously-included directories found matching 'dist' 07:27:34 INFO - no previously-included directories found matching '.git*' 07:27:34 INFO - Successfully installed jsonschema functools32 07:27:34 INFO - Cleaning up... 07:27:34 INFO - Return code: 0 07:27:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:34 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:34 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:27:34 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 functools32==3.2.3-2 07:27:34 INFO - Using env: {'DISPLAY': ':0', 07:27:34 INFO - 'HOME': '/home/cltbld', 07:27:34 INFO - 'LANG': 'en_US.UTF-8', 07:27:34 INFO - 'LANGUAGE': 'en_US:en', 07:27:34 INFO - 'LOGNAME': 'cltbld', 07:27:34 INFO - 'MAIL': '/var/mail/cltbld', 07:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:34 INFO - 'MOZ_NO_REMOTE': '1', 07:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:34 INFO - 'NO_EM_RESTART': '1', 07:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:34 INFO - 'PWD': '/builds/slave/test', 07:27:34 INFO - 'SHELL': '/bin/bash', 07:27:34 INFO - 'SHLVL': '1', 07:27:34 INFO - 'TERM': 'linux', 07:27:34 INFO - 'TMOUT': '86400', 07:27:34 INFO - 'USER': 'cltbld', 07:27:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:34 INFO - '_': '/tools/buildbot/bin/python'} 07:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:27:34 INFO - Cleaning up... 07:27:34 INFO - Return code: 0 07:27:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:34 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 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:34 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 07:27:34 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 07:27:34 INFO - Using env: {'DISPLAY': ':0', 07:27:34 INFO - 'HOME': '/home/cltbld', 07:27:34 INFO - 'LANG': 'en_US.UTF-8', 07:27:34 INFO - 'LANGUAGE': 'en_US:en', 07:27:34 INFO - 'LOGNAME': 'cltbld', 07:27:34 INFO - 'MAIL': '/var/mail/cltbld', 07:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:34 INFO - 'MOZ_NO_REMOTE': '1', 07:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:34 INFO - 'NO_EM_RESTART': '1', 07:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:34 INFO - 'PWD': '/builds/slave/test', 07:27:34 INFO - 'SHELL': '/bin/bash', 07:27:34 INFO - 'SHLVL': '1', 07:27:34 INFO - 'TERM': 'linux', 07:27:34 INFO - 'TMOUT': '86400', 07:27:34 INFO - 'USER': 'cltbld', 07:27:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:34 INFO - '_': '/tools/buildbot/bin/python'} 07:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:27:34 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 07:27:34 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 07:27:34 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 07:27:34 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 07:27:34 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 07:27:34 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 07:27:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27:36 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 07:27:36 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 07:27:36 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 07:27:36 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 07:27:36 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 07:27:36 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 07:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27:37 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 07:27:37 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 07:27:37 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 07:27:37 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 07:27:37 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 07:27:37 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 07:27:37 INFO - Downloading docopt-0.6.1.tar.gz 07:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:37 INFO - Running setup.py install for blobuploader 07:27:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:37 INFO - Running setup.py install for requests 07:27:37 INFO - Running setup.py install for docopt 07:27:38 INFO - Successfully installed blobuploader requests docopt 07:27:38 INFO - Cleaning up... 07:27:38 INFO - Return code: 0 07:27:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:38 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 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:38 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 07:27:38 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 07:27:38 INFO - Using env: {'DISPLAY': ':0', 07:27:38 INFO - 'HOME': '/home/cltbld', 07:27:38 INFO - 'LANG': 'en_US.UTF-8', 07:27:38 INFO - 'LANGUAGE': 'en_US:en', 07:27:38 INFO - 'LOGNAME': 'cltbld', 07:27:38 INFO - 'MAIL': '/var/mail/cltbld', 07:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:38 INFO - 'MOZ_NO_REMOTE': '1', 07:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:38 INFO - 'NO_EM_RESTART': '1', 07:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:38 INFO - 'PWD': '/builds/slave/test', 07:27:38 INFO - 'SHELL': '/bin/bash', 07:27:38 INFO - 'SHLVL': '1', 07:27:38 INFO - 'TERM': 'linux', 07:27:38 INFO - 'TMOUT': '86400', 07:27:38 INFO - 'USER': 'cltbld', 07:27:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:38 INFO - '_': '/tools/buildbot/bin/python'} 07:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:38 INFO - Running setup.py (path:/tmp/pip-wrVKkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:38 INFO - Running setup.py (path:/tmp/pip-wSY8gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:38 INFO - Running setup.py (path:/tmp/pip-4vwk8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:38 INFO - Running setup.py (path:/tmp/pip-67xxCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:38 INFO - Running setup.py (path:/tmp/pip-MlOdZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:38 INFO - Running setup.py (path:/tmp/pip-nuz6sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:38 INFO - Running setup.py (path:/tmp/pip-kYKYaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:38 INFO - Running setup.py (path:/tmp/pip-vm65c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:38 INFO - Running setup.py (path:/tmp/pip-6mPInO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:38 INFO - Running setup.py (path:/tmp/pip-fiZAE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:39 INFO - Running setup.py (path:/tmp/pip-BhpbYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:39 INFO - Running setup.py (path:/tmp/pip-HA4BZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:39 INFO - Running setup.py (path:/tmp/pip-R1dFwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:39 INFO - Running setup.py (path:/tmp/pip-ggHPYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:39 INFO - Running setup.py (path:/tmp/pip-yFL3kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:39 INFO - Running setup.py (path:/tmp/pip-m1fKIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:39 INFO - Running setup.py (path:/tmp/pip-tpKGp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:39 INFO - Running setup.py install for manifestparser 07:27:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:27:39 INFO - Running setup.py install for mozcrash 07:27:39 INFO - Running setup.py install for mozdebug 07:27:39 INFO - Running setup.py install for mozdevice 07:27:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:27:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:27:39 INFO - Running setup.py install for mozfile 07:27:40 INFO - Running setup.py install for mozhttpd 07:27:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Running setup.py install for mozinfo 07:27:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Running setup.py install for mozInstall 07:27:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Running setup.py install for mozleak 07:27:40 INFO - Running setup.py install for mozlog 07:27:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Running setup.py install for moznetwork 07:27:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Running setup.py install for mozprocess 07:27:40 INFO - Running setup.py install for mozprofile 07:27:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:27:40 INFO - Running setup.py install for mozrunner 07:27:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:27:41 INFO - Running setup.py install for mozscreenshot 07:27:41 INFO - Running setup.py install for moztest 07:27:41 INFO - Running setup.py install for mozversion 07:27:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:27:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:41 INFO - Cleaning up... 07:27:41 INFO - Return code: 0 07:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:41 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 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:41 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 07:27:41 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 07:27:41 INFO - Using env: {'DISPLAY': ':0', 07:27:41 INFO - 'HOME': '/home/cltbld', 07:27:41 INFO - 'LANG': 'en_US.UTF-8', 07:27:41 INFO - 'LANGUAGE': 'en_US:en', 07:27:41 INFO - 'LOGNAME': 'cltbld', 07:27:41 INFO - 'MAIL': '/var/mail/cltbld', 07:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:41 INFO - 'MOZ_NO_REMOTE': '1', 07:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:41 INFO - 'NO_EM_RESTART': '1', 07:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:41 INFO - 'PWD': '/builds/slave/test', 07:27:41 INFO - 'SHELL': '/bin/bash', 07:27:41 INFO - 'SHLVL': '1', 07:27:41 INFO - 'TERM': 'linux', 07:27:41 INFO - 'TMOUT': '86400', 07:27:41 INFO - 'USER': 'cltbld', 07:27:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:41 INFO - '_': '/tools/buildbot/bin/python'} 07:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:41 INFO - Running setup.py (path:/tmp/pip-aOvHn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:41 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)) 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:41 INFO - Running setup.py (path:/tmp/pip-qlAkjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:41 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)) 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:41 INFO - Running setup.py (path:/tmp/pip-LwLtS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:41 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)) 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:41 INFO - Running setup.py (path:/tmp/pip-JSOgAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:41 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)) 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:41 INFO - Running setup.py (path:/tmp/pip-n_9kdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:41 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)) 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:41 INFO - Running setup.py (path:/tmp/pip-eoAZJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:41 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)) 07:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:41 INFO - Running setup.py (path:/tmp/pip-wP5nmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:42 INFO - Running setup.py (path:/tmp/pip-2D9jNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:42 INFO - Running setup.py (path:/tmp/pip-JQve_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:42 INFO - Running setup.py (path:/tmp/pip-0J24CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:42 INFO - Running setup.py (path:/tmp/pip-qdefT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:42 INFO - Running setup.py (path:/tmp/pip-kqwU5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:42 INFO - Running setup.py (path:/tmp/pip-LjCsHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:42 INFO - Running setup.py (path:/tmp/pip-un6YLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:42 INFO - Running setup.py (path:/tmp/pip-MGI14l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:42 INFO - Running setup.py (path:/tmp/pip-x6k1j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:42 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)) 07:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:42 INFO - Running setup.py (path:/tmp/pip-N62r2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:42 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)) 07:27:42 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)) 07:27:42 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)) 07:27:42 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)) 07:27:42 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)) 07:27:42 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)) 07:27:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:42 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 07:27:42 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 07:27:42 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 07:27:42 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 07:27:42 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 07:27:42 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 07:27:44 INFO - Downloading blessings-1.6.tar.gz 07:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:44 INFO - Installing collected packages: blessings 07:27:44 INFO - Running setup.py install for blessings 07:27:44 INFO - Successfully installed blessings 07:27:44 INFO - Cleaning up... 07:27:44 INFO - Return code: 0 07:27:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:45 INFO - Reading from file tmpfile_stdout 07:27:45 INFO - Current package versions: 07:27:45 INFO - argparse == 1.2.1 07:27:45 INFO - blessings == 1.6 07:27:45 INFO - blobuploader == 1.2.4 07:27:45 INFO - docopt == 0.6.1 07:27:45 INFO - functools32 == 3.2.3-2 07:27:45 INFO - jsonschema == 2.5.1 07:27:45 INFO - manifestparser == 1.1 07:27:45 INFO - mozInstall == 1.12 07:27:45 INFO - mozcrash == 0.17 07:27:45 INFO - mozdebug == 0.1 07:27:45 INFO - mozdevice == 0.48 07:27:45 INFO - mozfile == 1.2 07:27:45 INFO - mozhttpd == 0.7 07:27:45 INFO - mozinfo == 0.9 07:27:45 INFO - mozleak == 0.1 07:27:45 INFO - mozlog == 3.4 07:27:45 INFO - moznetwork == 0.27 07:27:45 INFO - mozprocess == 0.23 07:27:45 INFO - mozprofile == 0.28 07:27:45 INFO - mozrunner == 6.12 07:27:45 INFO - mozscreenshot == 0.1 07:27:45 INFO - mozsystemmonitor == 0.3 07:27:45 INFO - moztest == 0.7 07:27:45 INFO - mozversion == 1.4 07:27:45 INFO - psutil == 3.1.1 07:27:45 INFO - requests == 1.2.3 07:27:45 INFO - wsgiref == 0.1.2 07:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:45 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 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:45 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 07:27:45 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 07:27:45 INFO - Using env: {'DISPLAY': ':0', 07:27:45 INFO - 'HOME': '/home/cltbld', 07:27:45 INFO - 'LANG': 'en_US.UTF-8', 07:27:45 INFO - 'LANGUAGE': 'en_US:en', 07:27:45 INFO - 'LOGNAME': 'cltbld', 07:27:45 INFO - 'MAIL': '/var/mail/cltbld', 07:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:45 INFO - 'MOZ_NO_REMOTE': '1', 07:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:45 INFO - 'NO_EM_RESTART': '1', 07:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:45 INFO - 'PWD': '/builds/slave/test', 07:27:45 INFO - 'SHELL': '/bin/bash', 07:27:45 INFO - 'SHLVL': '1', 07:27:45 INFO - 'TERM': 'linux', 07:27:45 INFO - 'TMOUT': '86400', 07:27:45 INFO - 'USER': 'cltbld', 07:27:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:45 INFO - '_': '/tools/buildbot/bin/python'} 07:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 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)) 07:27:45 INFO - Cleaning up... 07:27:45 INFO - Return code: 0 07:27:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:27:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:45 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 0x7f3a25fe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, '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': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', '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 07:27:45 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 07:27:45 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 07:27:45 INFO - Using env: {'DISPLAY': ':0', 07:27:45 INFO - 'HOME': '/home/cltbld', 07:27:45 INFO - 'LANG': 'en_US.UTF-8', 07:27:45 INFO - 'LANGUAGE': 'en_US:en', 07:27:45 INFO - 'LOGNAME': 'cltbld', 07:27:45 INFO - 'MAIL': '/var/mail/cltbld', 07:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:45 INFO - 'MOZ_NO_REMOTE': '1', 07:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:45 INFO - 'NO_EM_RESTART': '1', 07:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:45 INFO - 'PWD': '/builds/slave/test', 07:27:45 INFO - 'SHELL': '/bin/bash', 07:27:45 INFO - 'SHLVL': '1', 07:27:45 INFO - 'TERM': 'linux', 07:27:45 INFO - 'TMOUT': '86400', 07:27:45 INFO - 'USER': 'cltbld', 07:27:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:45 INFO - '_': '/tools/buildbot/bin/python'} 07:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:27:45 INFO - Cleaning up... 07:27:45 INFO - Return code: 0 07:27:45 INFO - Running post-action listener: _resource_record_post_action 07:27:45 INFO - Running post-action listener: _start_resource_monitoring 07:27:45 INFO - Starting resource monitoring. 07:27:45 INFO - [mozharness: 2016-10-31 14:27:45.702930Z] Finished create-virtualenv step (success) 07:27:45 INFO - [mozharness: 2016-10-31 14:27:45.703388Z] Running install step. 07:27:45 INFO - Running pre-action listener: _resource_record_pre_action 07:27:45 INFO - Running main action method: install 07:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:45 INFO - Reading from file tmpfile_stdout 07:27:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:27:45 INFO - Reading from file tmpfile_stdout 07:27:45 INFO - Output received: 07:27:45 INFO - Usage: mozinstall [options] installer 07:27:45 INFO - Options: 07:27:45 INFO - -h, --help show this help message and exit 07:27:45 INFO - -d DEST, --destination=DEST 07:27:45 INFO - Directory to install application into. [default: 07:27:45 INFO - "/builds/slave/test"] 07:27:45 INFO - --app=APP Application being installed. [default: firefox] 07:27:45 INFO - mkdir: /builds/slave/test/build/application 07:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:28:02 INFO - Reading from file tmpfile_stdout 07:28:02 INFO - Output received: 07:28:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:02 INFO - Running post-action listener: _resource_record_post_action 07:28:02 INFO - [mozharness: 2016-10-31 14:28:02.956918Z] Finished install step (success) 07:28:02 INFO - [mozharness: 2016-10-31 14:28:02.957264Z] Running run-tests step. 07:28:02 INFO - Running pre-action listener: _resource_record_pre_action 07:28:02 INFO - Running main action method: run_tests 07:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:02 INFO - Python 2.7.3 07:28:02 INFO - Return code: 0 07:28:02 INFO - grabbing minidump binary from tooltool 07:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:02 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2849930>, '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 0x284a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284acc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:02 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 07:28:02 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 07:28:02 INFO - Calling ['/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'] with output_timeout 600 07:28:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:03 INFO - Return code: 0 07:28:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 07:28:03 INFO - Using env: {'DISPLAY': ':0', 07:28:03 INFO - 'HOME': '/home/cltbld', 07:28:03 INFO - 'LANG': 'en_US.UTF-8', 07:28:03 INFO - 'LANGUAGE': 'en_US:en', 07:28:03 INFO - 'LOGNAME': 'cltbld', 07:28:03 INFO - 'MAIL': '/var/mail/cltbld', 07:28:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:03 INFO - 'MOZ_NO_REMOTE': '1', 07:28:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:03 INFO - 'NO_EM_RESTART': '1', 07:28:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:03 INFO - 'PWD': '/builds/slave/test', 07:28:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:03 INFO - 'SHELL': '/bin/bash', 07:28:03 INFO - 'SHLVL': '1', 07:28:03 INFO - 'TERM': 'linux', 07:28:03 INFO - 'TMOUT': '86400', 07:28:03 INFO - 'USER': 'cltbld', 07:28:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198', 07:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:03 INFO - '_': '/tools/buildbot/bin/python'} 07:28:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 07:28:03 INFO - mozversion application_buildid: 20161029093005 07:28:03 INFO - mozversion application_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 07:28:03 INFO - mozversion application_display_name: Nightly 07:28:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:03 INFO - mozversion application_name: Firefox 07:28:03 INFO - mozversion application_remotingname: firefox 07:28:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:28:03 INFO - mozversion application_vendor: Mozilla 07:28:03 INFO - mozversion application_version: 52.0a1 07:28:03 INFO - mozversion platform_buildid: 20161029093005 07:28:03 INFO - mozversion platform_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 07:28:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:28:03 INFO - mozversion platform_version: 52.0a1 07:28:03 INFO - using testdate: 1477924083 07:28:03 INFO - actual date: 1477924083 07:28:03 INFO - starting webserver on 'localhost:55012' 07:28:03 INFO - SUITE-START | Running 2 tests 07:28:03 INFO - TEST-START | dromaeo_css 07:28:03 INFO - operating with platform_type : linux_ 07:28:03 INFO - Initialising browser for dromaeo_css test... 07:28:03 INFO - TEST-INFO | started process 5999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRBSKdv/profile http://localhost:55012/getInfo.html) 07:28:07 INFO - PROCESS | 5999 | __metrics Screen width/height:1600/1200 07:28:07 INFO - PROCESS | 5999 | colorDepth:24 07:28:07 INFO - PROCESS | 5999 | Browser inner width/height: 1024/697 07:28:07 INFO - PROCESS | 5999 | __metrics 07:28:07 INFO - PROCESS | 5999 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:28:07 INFO - PROCESS | 5999 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:08 INFO - PROCESS | 5999 | console.error: PushService: 07:28:08 INFO - PROCESS | 5999 | stateChangeProcessEnqueue: Error transitioning state 07:28:08 INFO - PROCESS | 5999 | UnknownError 07:28:08 INFO - TEST-INFO | 5999: exit 0 07:28:08 INFO - Browser initialized. 07:28:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:08 INFO - TEST-INFO | started process 6083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRBSKdv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:20 INFO - PROCESS | 6083 | RSS: Main: 174637056 07:28:20 INFO - PROCESS | 6083 | 07:29:12 INFO - PROCESS | 6083 | 1477924152202 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] 07:31:22 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:55012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55012/tests/dromaeo/cssquery-ext.html) 07:31:23 INFO - PROCESS | 6083 | RSS: Main: 315895808 07:31:23 INFO - PROCESS | 6083 | 07:34:26 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:55012/tests/dromaeo/cssquery-ext.html (next: http://localhost:55012/tests/dromaeo/cssquery-jquery.html) 07:34:26 INFO - PROCESS | 6083 | RSS: Main: 286224384 07:34:26 INFO - PROCESS | 6083 | 07:37:28 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:55012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55012/tests/dromaeo/cssquery-mootools.html) 07:37:29 INFO - PROCESS | 6083 | RSS: Main: 219975680 07:37:29 INFO - PROCESS | 6083 | 07:40:31 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:55012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55012/tests/dromaeo/cssquery-prototype.html) 07:40:32 INFO - PROCESS | 6083 | RSS: Main: 220581888 07:40:32 INFO - PROCESS | 6083 | 07:43:34 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:55012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55012/tests/dromaeo/cssquery-yui.html) 07:43:35 INFO - PROCESS | 6083 | RSS: Main: 219746304 07:43:35 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:55012/tests/dromaeo/cssquery-yui.html (next: http://localhost:55012/tests/dromaeo/cssquery-dojo.html) 07:46:38 INFO - PROCESS | 6083 | RSS: Main: 307404800 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | __start_tp_report 07:46:38 INFO - PROCESS | 6083 | _x_x_mozilla_page_load 07:46:38 INFO - PROCESS | 6083 | _x_x_mozilla_page_load_details 07:46:38 INFO - PROCESS | 6083 | |i|pagename|runs| 07:46:38 INFO - PROCESS | 6083 | |0;dojo.html;2934.853257337133;2958.3433277364666;2966.8961586344476;2979.851007449627;3001.0696684027953;4884.53596908294;4997.80008799648;5042.1428357179275;5085.4151772546165;5134.358205224347;5050.545450909417;5069.79720811168;5135.178371460567;5146.639735218536;5170.9482905170935;4576.679632425723;4603.654725895554;4642.628589712832;4655.4878963314;4673.485916549177;4127.938080928789;4613.8154473821005;4690.7654617269;4702.200625893606;4702.647301452388;4468.776561171929;4698.718076915396;4711.0342379812055;4739.194336962707;4818.542238487338;4517.706349087332;4598.0344127733215;4608.792604332813;4671.392718946549;4672.57946784791;4623;4623.006053698437;4639.953600463986;4684.414448193976;4699.78850951708;5047.798088076473;5080.5173508517;5104.872378190538;5109.978004399098;5156.407013193456;5218.452062533417;5258.474152584749;5263.210518422229;5334.759935802898;5416.052190866582;5340.198970154469;5342.332208473941;5350.143976963706;5358.812441564565;5364.034473794715;4964.60283177345;5021.899562008739;5022.347094877642;5024.522670346311;5027.421846487628;5397.8110766123;5477.7261136943;5579.38626751057;5590.105583106683;5594.692291923902;5267.815626453055;5306.787728490895;5314.229436731653;5317.973410132925;5362.034833729966;5377.569794416438;5386.649867758583;5389.51494365509;5395.568354531628;5452.836414907559;5164.948350516522;5214.478552144831;5341.759620817073;5355.919661205085;5416.160495123262;5434.592405569519;5440.483154100354;5449.754761035683;5494.80768173112;5507.421720719347;4213.6839737019845;4216.578342165821;4217.704760666786;4227.450431443893;4273.444452221192;3667.651573100551;3691.2617476504806;3768.8492460301827;3810.7713537187856;3822.904427389282;5037.697738135724;5106.591472682177;5108.412532558729;5117.616178786606;5196.324477817935;5423.430539793344;5430.940966511493;5433.347998240237;5444.727763611803;5446;5096.261042148868;5102.4897510248675;5124.871878203075;5127.66670166438;5166.940777140677;4534.274516077412;4577.656675749266;4657.767111644404;4702.083093796677;4704.223803072523;5552.3892371839065;5555.583331250173;5559.11054231321;5559.471850174227;5604.775808967595;5400.297961265011;5440.782368705208;5454.236406902957;5458.754356054066;5519.420460851553;5237.502437268454;5302.973485132549;5582.218489411404;5584.106542953108;5635.436456354331;5365.758540865749;5367.51692347675;5372.221027951004;5433.918491222714;5434.184872269191;5374.973125134349;5431.755570999394;5439.3200849893765;5444.50999410055;5509.256250406143;5068.138416469283;5123.180291153398;5276.920846187387;5302.840914772563;5321.3348331458565;5296.205569164502;5349.1976203569775;5349.598780091431;5390.460953904578;5406.864828379322;5275.366955965309;5321.467853214647;5329.467053294795;5341.893162136657;5385.838424847261;5126.307948426915;5173.4826517347965;5380.246765452762;5380.273663055594;5389.7035663038905;5132.5893928486375;5169.586433085419;5173.741312934413;5175.689458632494;5230.032443997872 07:46:38 INFO - PROCESS | 6083 | |1;ext.html;570.5948776368778;577.4312302382153;581.3082431906034;583.1049339264229;602.9547783916207;31175.53236701451;41960;43296.134077318435;43344.78327608362;47268.29097563539;44606;44906.10187796242;44966.55033449664;44971.77514112425;45059.324110138296;8736.650533978649;8879.28965682747;8885.555722213896;8891.110888911122;8893.377463577552;7922.524648521107;8128.796780080486;10321.225908056887;10567.841482377771;10590.046895779378;10794.352338859655;10842.457877106153;10848;10851.51168197433;10853;10521.210909181842;10605.628802991936;10612.681619551426;10666.093382062534;10682.03861652455;10468.47657617116;10574.682759517227;10601;10609.522571484302;10614.628488002883;41299.58700412988;41675;41690.79154604208;41719;41735.79132104351;3277.918052048694;3505.7545971781988;3666.468362087509;3992.7604343739467;3994.0613955720382;30789.230269243224;31934.20164495883;31989;32014.199645009063;32093.679063209303;4326.870193894157;4395.7362558246605;4415.845445409395;4599.977000114978;4604.470485894131;329368;330587;331388;332448;334715;55217;55790.16314755282;55875.441245587026;55887.44112558904;55985.44014559884;58617.41382586205;58647;58706.41293587095;58735.41264587385;58836;15521.767173492406;15673.608159796097;15678.529644110695;15678.843211567966;15684.058956462648;11663.533458661559;11702.590409335633;11714.121440891968;11757;11910.225835320676;14369.13785172893;14383.424663013362;14425.826318209976;15177.24113794306;15663.216839157996;5348.277982472394;6023.427774361428;6055.8486037848525;6156.138140660311;6202.968985155136;963.3545524498603;1012.5342342522522;1018.4805749068029;1028.3675539543126;1048.3290693955873;31071.373454869783;31284.687153128634;31439.84280078585;31634.36731265362;32095.679043209268;1066.7173199102244;1069.8662667166604;1072.254782925859;1086.4839201379282;1125.2011072138873;16386.590335241475;16393.344266229455;16400.671986560203;16430.424935127212;16723.581910452336;480313;484794;485672;504798;740893;49162.26256606154;50049.99600031989;58125;59092.40907590869;59742;1346.898982576291;1360.8366995960548;1372.9176249425066;1376.0298989212781;1382.7969666390304;30107;32112;32857.671423285465;32872;34919.65080349164;54008.72995634997;54642.180367293724;54690;54691;54703.17945230745;356752;357751;358147;358416;358494;26807.329816754736;27244.455110898067;27256.863715681295;27281.181564553095;27302.590461142703;45958.080838383714;46063.76968115138;46096.07807843891;46111.53888461072;47535.28697069616;39354.409683854195;39654.80172599119;39795;40053.799731001156;41594.58405416028;38817.22365552617;39666.60333396745;39764.80117599393;39912.40131397973;40629.1874162521;39785.60214397935;40259.39610905897;40481.59518404896;40677;41251.79374103231;33831.49252761161;36278.637213627524;36981.63018369889;37024.444633329986;37131.814340928126;27061.188164354313;27259.318517037234;27306.317342066606;27409.314767130185;27497.45005099847 07:46:38 INFO - PROCESS | 6083 | |2;jquery.html;370.97959612221354;375.92105657811857;377.3076404797197;383.601054902901;386.1273521840641;14146;17979.910100449495;18578.814211857876;18652.160652770624;19778.208871645118;17919.552011199725;17924.731129033044;18093.27626894926;18185.727214091767;18341;5622.634528755638;5930.021546444831;5936;5942.732577034044;5946.910796338058;4170.436991006206;4330.220560299145;4338.631216346615;5768.163616275638;5881.117832325164;6570;6578.407943285103;6692.196936367618;6698.196216454008;6708.932910670904;6402.455791257748;6468.353164683517;6495.382938620824;6502.577332473422;6683.498737594676;5621.7236838836225;5670.773169073233;5675.404082571353;5680.886382272372;5684.8010319638615;21141.471463213387;21976;23068.307950761337;23348.533029339316;23486.530269394687;2271.965920511194;2293.3578597992587;2340.871252081135;2505.235903049569;2909.806979138564;9295.442273463546;9877.555510002067;10388.117010054155;10765.354078755221;11298.943505282503;1903.486058764126;1930.1989674285155;1951.980480195194;1968.4488343263909;1987.920483180671;78811.6059419705;80134.59932700357;85594.57202713947;85828.14171858264;86528;10431.530581123867;10536.420496872746;10753.623623173307;10864.402457864735;10926.125909927187;15037.172955487553;15125.848741512664;15154.545363639108;15156.696866062617;15158.848411515964;7780.766577002699;8002.439829211899;8131.390145739093;8290.875636865452;8302.252797248277;7691.461597688108;7718.498297610638;7770.41721870862;7939.444238903337;8004.79988000293;4559.635229181657;4576.153411618861;4580.88547786308;4593.839215627504;4615.284630882152;1823.881447705895;1887.169645356039;1894.3748562974185;1906.8855868647925;1917.6931690929664;880.9163129502687;1014.878214614251;1058.2750815691277;1058.539535302146;1064.6486659402533;18975.81024189768;19665.606687866162;19764;19800.405987820388;19944.20223191056;975.3075316525204;993.0813997052697;1006.7533454303742;1037.6562351754496;1037.9377237365782;10449.268551201494;10733.302335348177;10826.404547749791;10857.13142948578;10867.728306792393;445148;450412;453844;468367;470807;52470.21294680583;62503;85060.57469712613;88823.55588222017;89963.55018224867;947.36999895069;980.9607615695435;1008.7679833638158;1013.2046343620223;1015.3653966271081;16414.67170656556;17121.400750973655;17265.82734172642;17307.2211750469;17441.38955136615;40693.79653101716;40953;41278.587214127474;41615.1676966465;41700;54136;54678.453215467336;55654.72172639111;57077.71461142668;57325;7004.509684322048;7468.290512401313;8328.750137495885;8460.196281353261;8784.604692788713;12477.75044499123;12500.499980000699;12913;13018.15382000167;13400.396982135633;10809.405482698527;11467.885321146681;11579.594714184963;11589.82615260755;11778.175527712978;11046.171537134907;11562.421878906189;11733.941330293294;11739.06087513014;11858.407079646156;11722.472488737856;11823.645290641294;11860.288382697066;12072.456739446921;12375.381230938598;7223;7664.118626357817;7724.266194711493;7881.448298619041;8075.5558444286125;9078.001419843944;11464.426778660867;11521.596744113916;11756.23584467007;11800.940995294968 07:46:38 INFO - PROCESS | 6083 | |3;mootools.html;1280.1870812034367;1381.2748307138754;1420.2614640386998;1528.4268399350244;1702.1319127245108;6974.16310042795;7715.421343399246;7931.643076061577;7938.9603051984805;8106.148854370294;7999.240072193147;8068.556229407381;8074.111847696749;8075.353971682266;8080.959595202015;2224.154821167958;2244.1023590563823;2244.9438764030865;2246.640537513998;2255.3008567344095;2147.3128598848375;2206.172685243034;2226.031676220841;2227.8106360959337;2235.3852690510157;2192.27654873892;2194.561087782442;2214;2224.2659922225625;2235.418791114314;2152.2897443843494;2156.4716644422138;2173.6848157017225;2173.8586991845636;2174.0325555127974;2157.2126173946554;2176.651735722277;2179.063002908749;2179.302623160589;2182.5962196993605;7782.416318776114;7895.802604934923;7961.840763184704;7962.203779621991;7975.082865470487;4916.8770780730765;5117.795288188468;5130.102232109366;5136;5139.383274007106;3245.2049247934406;3326.168457885529;3373.443381841993;3419.9658003419895;3422.8973130805866;1134.1720544002842;1135.6422726841101;2079.8232150267245;2102.8107470327745;2179.2154824263253;10973.890261097367;10999.780004399867;11038;11068.39123848188;11072.058874995635;4067.633912947849;4245.27830268855;4311.353297005474;4348.847790327387;4355.194289056535;8660.8700869487;8668.78328041804;8669.959604847332;8672.176143266379;8673.176048275403;4929.137400954819;4958.057968985953;4961.131801934647;4964.826231081895;4966.1309270877455;3865.4974853268895;4068.4304197412384;4142.979285103555;4610.124076425468;4662.230731929194;3443.362977849056;3468.514407982884;3522.18989632386;3531.134871956387;3538.7876727396438;1061.7186445591924;1063.9361638301573;1079.228351728518;1079.740862193068;1081.0702795595782;802.173761026144;814.3159745813426;837.7046495585679;876.8860048193694;915.2037727177399;5035.697858128524;5236.711980841014;5295.920561191585;5436.565074794007;5438.972805135949;403.6871424645923;408.7547471517066;424.79185199252146;445.72587858466807;450.9481409637868;3445.793252404864;3493.4934434507363;3540.2565461253425;3588.9282214355567;3656.689181419609;9481;9785.266105042008;9886.060824221688;9889.80220395588;9908.80182396348;9745;9794;9801.411915285105;9847.556859941176;9862.112409883002;7208.243134470805;7516.872469129675;7663.655135518915;7664.386849052063;7668.80827979305;5060.291559181644;5387.973060134675;5421.810236641699;5503.394626591152;5684.772609095755;8935.463872167691;8950.731478055668;8964.103589641245;8978.506182160045;9044.547772611211;8358.498490090615;9018.639254429749;9342.579583918876;9376.67181648639;9502.334836561375;6735.360140786617;6901.413379862567;7007.509474336747;7099.538529995741;7212.062431883822;7628.618569071636;7698.769036928901;7715.074191097105;7745.961270193839;7779;6986.895196572157;6994.33553812387;7026.156861176692;7042.0493233412835;7047.541909775849;6755.42578880781;6775.390214880685;6817.147856517935;6822.522423430511;6856.725730970905;6097.420745029215;6182.381761823782;6192.876142477216;6197.566170368031;6204.720787564661;4606.976965115153;4734.55021772931;4748.311494833299;4777.474477807508;4831.782569784298;4636.65225108125;4742.691725037862;4747.881302967316;4899.608031357411;4935.851924442272 07:46:38 INFO - PROCESS | 6083 | |4;prototype.html;327.36327842346634;333.8214055480317;335.19720269953467;338.59199664404395;340.7069919868914;5282.392524859638;5329.840104796862;5341.252224688542;5347.679139251648;5359.866003349914;5244.187150991593;5259.474052594738;5268.209768534722;5271.894562108756;5277.1556550951855;3947.467091942594;4012.498437695288;4038.9394159087637;4083.2650122977852;4122;4101.651359634435;4107.650849677781;4121.670266378697;4127.525334586531;4146.502419709639;4076.6331030207275;4085.836566537335;4092.1611069730784;4093.8362465501345;4102.2104968621325;3696.445533170019;3873.7288389812725;3943.605639436062;4095.242380159665;4111.629953304187;3598.1544337080763;3611.368010598135;3629.6007439181667;3646.762960407565;3648.5986541480415;5080;5090.643654944155;5094.821681241138;5103.2855400244;5153.716545589991;4543.273076307775;4717.315989181584;4718.952810471886;4730.929036064462;4741.739204343759;5492.615516913817;5500.312460942382;5514.766519559585;5515.4760297771645;5515.917261241085;4024.8993775155564;4035.1324465239823;4037.315185401704;4040.272750904836;4045.4538637284177;5482.451754824526;5736.397678243808;5759.667334729441;5774.364819869811;5775.249217601685;4025.255327764314;4037.4549435826375;4041.333180025263;4045.110075783323;4046.959530404717;4087.9371363445125;4091.3453847384276;4093.3041382964966;4096.774677392712;4106.2198182345255;4508.301213311942;4619.145458090264;4682.438107427062;4688.671792974527;4696.2486002239475;5504.651360416643;5510.913888222528;5513.393526712059;5530.6128570999645;5530.917036244459;1395.7417877692455;1410.6261840612246;1413.2439145057344;1416.3272445588264;1422.7936949142315;904.3669431398048;913.9177474027236;913.949732764691;919.296737995434;923.3721069672687;5232.712200828915;5269.366496386133;5276.683398996072;5281.656692314988;5289.545375021899;5619.943800562024;5647.915281270784;5652.519535839418;5686.943130568724;5691.743871525791;5159.664621799571;5325.440828713007;5379.193121031876;5381.973090134525;5386.461353864583;2994.595729576523;3004.969950300469;3005.7294843463756;3012.322227498795;3019.667836537979;5787.643166963151;5796.971015144897;5812.505936995402;5824.504917082096;5839.678817664984;5525.502704756511;5777.7977770777825;5811.4479124483105;5816.680082595498;5849.356570777211;5845.590808643354;5852.209951656557;5871.4128587141795;5877.4122587740885;5879.647221166743;5583.246261754611;5716.199732037435;5731.340895797037;5749.770009199752;5760.366359700513;5575.386707462257;5593.9440605595055;5616.831495055155;5663.7451314690115;5666.490015898589;5731.283589551306;5873.238028591491;5894.145348924468;5896.852578685567;5903.911441328298;4038.1519880825354;4072.045418199222;4075.449814275035;4077.388391741144;4093.5263305210697;5658.236138121466;5663.575231857545;5695.886082278248;5699.974004679032;5732.598718089694;5295.4439783822145;5500.394956554695;5542.889142217214;5568.6658800472105;5585.3297604287745;5514.5864060194845;5540.196671482693;5540.445955404427;5554.666719996813;5559.444055594408;5487.5884308677805;5504.697241651587;5530.419305972976;5538.750756215899;5544.500994910478;5371.758270877898;5468.371137319259;5501.642393244426;5531.640443371168;5533.446655334435;5386.8383948481605;5402.054640437829;5406.783473718382;5414.485623865727;5445.482679145475 07:46:38 INFO - PROCESS | 6083 | |5;yui.html;729.2088084428395;733.9449541284405;736.9852602947941;791.1020991175022;821.9136990615985;14191.432342706292;15099.094054356747;15116.848831511708;15269.08385496871;15275.388984440622;13986.440542378292;14155.504557340495;14176.716465670681;14194.503192388269;14199.858001419983;653.1182903080827;672.1161672400801;780.8945792318021;796.976090717278;805.4965646470955;790.9644066017014;803.6142651527271;803.9879401808948;804.4690504267185;804.5534728225832;849.0787495567317;849.1932663969254;849.8937632795901;850.2262940723942;850.5067061104545;688.3838964127078;696.8606278744221;824.826786374862;846.124261389462;846.1411667157839;625.1185827982523;627.0969803483016;627.1314229791726;627.4760574919902;627.7865525721277;13732.382042808098;13860.4455821767;13891.4443422264;13913.234772087531;13981.300934953313;13893.305334733222;13934.790978135336;13962.441502339894;14070.92964535181;14199.574012779633;12239.32683702396;12416.379181040911;12421.254724716546;12817.03872209588;12818;4355.84754533593;4402.119576084796;4434;4593.609543188833;4599.195140850371;68589.31410685879;69667.95498067584;70989;71843.28156718418;72318.63840680815;10949.288296260718;11054.336739795637;11135.164862635334;11355.148363872577;11440.256383335056;19901.203951841766;19933;19976.500587485138;19977.300794472125;20084.598308033757;8267.669293228324;8368.623411946477;8407.369447291478;8485.448445851123;8695.217430431292;4412.69111162222;4701.106789709944;4778.068276686013;4856.80572777092;4886.169351210303;3241.578594782663;3304;3337.7997320160866;3338.165458635341;3341.799492030486;553.9806106786243;554.1217170784272;555.084111216496;569.9601027928088;573.5984810632574;643.7264162730914;671.6767967104796;692.1486571516962;694.6144889586328;705.4744215559441;9066.682666106655;9182.403143795633;9222.677206297882;9420;9448.102430269113;521.0802932823569;569.5671289819767;634.501915995941;687.3126873126873;708.0476758759461;4128.545859955402;4357.8256869724855;4415.183191109655;4457.551295828868;4501.29147625668;61720.69139654273;68874;86718.56640716882;93272.53363733138;93719;70138.64930675314;71852;73144.26855731374;73892.63053684805;74704.62647686836;65820.67089664521;66293;67987.66006170037;68300.31699683038;69618.30381696118;8957.14907083826;9203;9213.723588292361;9249.861252081359;9302.441853488812;44991;45185.99999999868;45562.31656525088;45709.77145114386;46187.30719039284;55370;59611.40388596232;60408.69795650994;62127.689361552904;65629.67185164044;12405.62783116508;12470.5011799527;12500.93637167193;12579.371031448574;12937.805932911202;14310.356033978704;14337.56987290383;14611.269436527919;14663.340149693076;14675.706485870436;13028.804567931678;13063.216207027608;13486.881276545057;13775.862241377457;14253.572392828231;12475.625731228078;12708.759266387013;12747.973947198403;13033.543825966046;13201.867981320449;12721.93639031799;12890.41993110331;12914.80627790565;13165;13167.47330106785;10912.236143469881;10918.290311129751;11594.884051159717;12157.635270941886;12169.513219471122;11201.88798112041;11297.661070167907;11374.545018199511;11514.539418423505;11667.883321166679 07:46:38 INFO - PROCESS | 6083 | __end_tp_report 07:46:38 INFO - PROCESS | 6083 | __start_cc_report 07:46:38 INFO - PROCESS | 6083 | _x_x_mozilla_cycle_collect,1375 07:46:38 INFO - PROCESS | 6083 | __end_cc_report 07:46:38 INFO - PROCESS | 6083 | __startTimestamp1477925198638__endTimestamp 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | ------- Summary: start ------- 07:46:38 INFO - PROCESS | 6083 | Number of tests: 6 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | [#0] dojo.html Cycles:165 Average:5030.92 Median:5175.69 stddev:553.24 (10.7%) stddev-sans-first:529.93 07:46:38 INFO - PROCESS | 6083 | Values: 2934.9 2958.3 2966.9 2979.9 3001.1 4884.5 4997.8 5042.1 5085.4 5134.4 5050.5 5069.8 5135.2 5146.6 5170.9 4576.7 4603.7 4642.6 4655.5 4673.5 4127.9 4613.8 4690.8 4702.2 4702.6 4468.8 4698.7 4711.0 4739.2 4818.5 4517.7 4598.0 4608.8 4671.4 4672.6 4623.0 4623.0 4640.0 4684.4 4699.8 5047.8 5080.5 5104.9 5110.0 5156.4 5218.5 5258.5 5263.2 5334.8 5416.1 5340.2 5342.3 5350.1 5358.8 5364.0 4964.6 5021.9 5022.3 5024.5 5027.4 5397.8 5477.7 5579.4 5590.1 5594.7 5267.8 5306.8 5314.2 5318.0 5362.0 5377.6 5386.6 5389.5 5395.6 5452.8 5164.9 5214.5 5341.8 5355.9 5416.2 5434.6 5440.5 5449.8 5494.8 5507.4 4213.7 4216.6 4217.7 4227.5 4273.4 3667.7 3691.3 3768.8 3810.8 3822.9 5037.7 5106.6 5108.4 5117.6 5196.3 5423.4 5430.9 5433.3 5444.7 5446.0 5096.3 5102.5 5124.9 5127.7 5166.9 4534.3 4577.7 4657.8 4702.1 4704.2 5552.4 5555.6 5559.1 5559.5 5604.8 5400.3 5440.8 5454.2 5458.8 5519.4 5237.5 5303.0 5582.2 5584.1 5635.4 5365.8 5367.5 5372.2 5433.9 5434.2 5375.0 5431.8 5439.3 5444.5 5509.3 5068.1 5123.2 5276.9 5302.8 5321.3 5296.2 5349.2 5349.6 5390.5 5406.9 5275.4 5321.5 5329.5 5341.9 5385.8 5126.3 5173.5 5380.2 5380.3 5389.7 5132.6 5169.6 5173.7 5175.7 5230.0 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | [#1] ext.html Cycles:180 Average:57266.00 Median:197386.32 stddev:112555.31 (57.0%) stddev-sans-first:112790.56 07:46:38 INFO - PROCESS | 6083 | Values: 570.6 577.4 581.3 583.1 603.0 31175.5 41960.0 43296.1 43344.8 47268.3 44606.0 44906.1 44966.6 44971.8 45059.3 8736.7 8879.3 8885.6 8891.1 8893.4 7922.5 8128.8 10321.2 10567.8 10590.0 10794.4 10842.5 10848.0 10851.5 10853.0 10521.2 10605.6 10612.7 10666.1 10682.0 10468.5 10574.7 10601.0 10609.5 10614.6 41299.6 41675.0 41690.8 41719.0 41735.8 3277.9 3505.8 3666.5 3992.8 3994.1 30789.2 31934.2 31989.0 32014.2 32093.7 4326.9 4395.7 4415.8 4600.0 4604.5 329368.0 330587.0 331388.0 332448.0 334715.0 55217.0 55790.2 55875.4 55887.4 55985.4 58617.4 58647.0 58706.4 58735.4 58836.0 15521.8 15673.6 15678.5 15678.8 15684.1 11663.5 11702.6 11714.1 11757.0 11910.2 14369.1 14383.4 14425.8 15177.2 15663.2 5348.3 6023.4 6055.8 6156.1 6203.0 963.4 1012.5 1018.5 1028.4 1048.3 31071.4 31284.7 31439.8 31634.4 32095.7 1066.7 1069.9 1072.3 1086.5 1125.2 16386.6 16393.3 16400.7 16430.4 16723.6 480313.0 484794.0 485672.0 504798.0 740893.0 49162.3 50050.0 58125.0 59092.4 59742.0 1346.9 1360.8 1372.9 1376.0 1382.8 30107.0 32112.0 32857.7 32872.0 34919.7 54008.7 54642.2 54690.0 54691.0 54703.2 356752.0 357751.0 358147.0 358416.0 358494.0 26807.3 27244.5 27256.9 27281.2 27302.6 45958.1 46063.8 46096.1 46111.5 47535.3 39354.4 39654.8 39795.0 40053.8 41594.6 38817.2 39666.6 39764.8 39912.4 40629.2 39785.6 40259.4 40481.6 40677.0 41251.8 33831.5 36278.6 36981.6 37024.4 37131.8 27061.2 27259.3 27306.3 27409.3 27497.5 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | [#2] jquery.html Cycles:180 Average:27515.77 Median:2707.52 stddev:75426.63 (2785.8%) stddev-sans-first:75610.68 07:46:38 INFO - PROCESS | 6083 | Values: 371.0 375.9 377.3 383.6 386.1 14146.0 17979.9 18578.8 18652.2 19778.2 17919.6 17924.7 18093.3 18185.7 18341.0 5622.6 5930.0 5936.0 5942.7 5946.9 4170.4 4330.2 4338.6 5768.2 5881.1 6570.0 6578.4 6692.2 6698.2 6708.9 6402.5 6468.4 6495.4 6502.6 6683.5 5621.7 5670.8 5675.4 5680.9 5684.8 21141.5 21976.0 23068.3 23348.5 23486.5 2272.0 2293.4 2340.9 2505.2 2909.8 9295.4 9877.6 10388.1 10765.4 11298.9 1903.5 1930.2 1952.0 1968.4 1987.9 78811.6 80134.6 85594.6 85828.1 86528.0 10431.5 10536.4 10753.6 10864.4 10926.1 15037.2 15125.8 15154.5 15156.7 15158.8 7780.8 8002.4 8131.4 8290.9 8302.3 7691.5 7718.5 7770.4 7939.4 8004.8 4559.6 4576.2 4580.9 4593.8 4615.3 1823.9 1887.2 1894.4 1906.9 1917.7 880.9 1014.9 1058.3 1058.5 1064.6 18975.8 19665.6 19764.0 19800.4 19944.2 975.3 993.1 1006.8 1037.7 1037.9 10449.3 10733.3 10826.4 10857.1 10867.7 445148.0 450412.0 453844.0 468367.0 470807.0 52470.2 62503.0 85060.6 88823.6 89963.6 947.4 981.0 1008.8 1013.2 1015.4 16414.7 17121.4 17265.8 17307.2 17441.4 40693.8 40953.0 41278.6 41615.2 41700.0 54136.0 54678.5 55654.7 57077.7 57325.0 7004.5 7468.3 8328.8 8460.2 8784.6 12477.8 12500.5 12913.0 13018.2 13400.4 10809.4 11467.9 11579.6 11589.8 11778.2 11046.2 11562.4 11733.9 11739.1 11858.4 11722.5 11823.6 11860.3 12072.5 12375.4 7223.0 7664.1 7724.3 7881.4 8075.6 9078.0 11464.4 11521.6 11756.2 11800.9 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | [#3] mootools.html Cycles:180 Average:5253.04 Median:5000.91 stddev:2912.15 (58.2%) stddev-sans-first:2905.01 07:46:38 INFO - PROCESS | 6083 | Values: 1280.2 1381.3 1420.3 1528.4 1702.1 6974.2 7715.4 7931.6 7939.0 8106.1 7999.2 8068.6 8074.1 8075.4 8081.0 2224.2 2244.1 2244.9 2246.6 2255.3 2147.3 2206.2 2226.0 2227.8 2235.4 2192.3 2194.6 2214.0 2224.3 2235.4 2152.3 2156.5 2173.7 2173.9 2174.0 2157.2 2176.7 2179.1 2179.3 2182.6 7782.4 7895.8 7961.8 7962.2 7975.1 4916.9 5117.8 5130.1 5136.0 5139.4 3245.2 3326.2 3373.4 3420.0 3422.9 1134.2 1135.6 2079.8 2102.8 2179.2 10973.9 10999.8 11038.0 11068.4 11072.1 4067.6 4245.3 4311.4 4348.8 4355.2 8660.9 8668.8 8670.0 8672.2 8673.2 4929.1 4958.1 4961.1 4964.8 4966.1 3865.5 4068.4 4143.0 4610.1 4662.2 3443.4 3468.5 3522.2 3531.1 3538.8 1061.7 1063.9 1079.2 1079.7 1081.1 802.2 814.3 837.7 876.9 915.2 5035.7 5236.7 5295.9 5436.6 5439.0 403.7 408.8 424.8 445.7 450.9 3445.8 3493.5 3540.3 3588.9 3656.7 9481.0 9785.3 9886.1 9889.8 9908.8 9745.0 9794.0 9801.4 9847.6 9862.1 7208.2 7516.9 7663.7 7664.4 7668.8 5060.3 5388.0 5421.8 5503.4 5684.8 8935.5 8950.7 8964.1 8978.5 9044.5 8358.5 9018.6 9342.6 9376.7 9502.3 6735.4 6901.4 7007.5 7099.5 7212.1 7628.6 7698.8 7715.1 7746.0 7779.0 6986.9 6994.3 7026.2 7042.0 7047.5 6755.4 6775.4 6817.1 6822.5 6856.7 6097.4 6182.4 6192.9 6197.6 6204.7 4607.0 4734.6 4748.3 4777.5 4831.8 4636.7 4742.7 4747.9 4899.6 4935.9 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | [#4] prototype.html Cycles:180 Average:4653.39 Median:5344.47 stddev:1372.94 (25.7%) stddev-sans-first:1337.84 07:46:38 INFO - PROCESS | 6083 | Values: 327.4 333.8 335.2 338.6 340.7 5282.4 5329.8 5341.3 5347.7 5359.9 5244.2 5259.5 5268.2 5271.9 5277.2 3947.5 4012.5 4038.9 4083.3 4122.0 4101.7 4107.7 4121.7 4127.5 4146.5 4076.6 4085.8 4092.2 4093.8 4102.2 3696.4 3873.7 3943.6 4095.2 4111.6 3598.2 3611.4 3629.6 3646.8 3648.6 5080.0 5090.6 5094.8 5103.3 5153.7 4543.3 4717.3 4719.0 4730.9 4741.7 5492.6 5500.3 5514.8 5515.5 5515.9 4024.9 4035.1 4037.3 4040.3 4045.5 5482.5 5736.4 5759.7 5774.4 5775.2 4025.3 4037.5 4041.3 4045.1 4047.0 4087.9 4091.3 4093.3 4096.8 4106.2 4508.3 4619.1 4682.4 4688.7 4696.2 5504.7 5510.9 5513.4 5530.6 5530.9 1395.7 1410.6 1413.2 1416.3 1422.8 904.4 913.9 913.9 919.3 923.4 5232.7 5269.4 5276.7 5281.7 5289.5 5619.9 5647.9 5652.5 5686.9 5691.7 5159.7 5325.4 5379.2 5382.0 5386.5 2994.6 3005.0 3005.7 3012.3 3019.7 5787.6 5797.0 5812.5 5824.5 5839.7 5525.5 5777.8 5811.4 5816.7 5849.4 5845.6 5852.2 5871.4 5877.4 5879.6 5583.2 5716.2 5731.3 5749.8 5760.4 5575.4 5593.9 5616.8 5663.7 5666.5 5731.3 5873.2 5894.1 5896.9 5903.9 4038.2 4072.0 4075.4 4077.4 4093.5 5658.2 5663.6 5695.9 5700.0 5732.6 5295.4 5500.4 5542.9 5568.7 5585.3 5514.6 5540.2 5540.4 5554.7 5559.4 5487.6 5504.7 5530.4 5538.8 5544.5 5371.8 5468.4 5501.6 5531.6 5533.4 5386.8 5402.1 5406.8 5414.5 5445.5 07:46:38 INFO - PROCESS | 6083 | 07:46:38 INFO - PROCESS | 6083 | [#5] yui.html Cycles:180 Average:17732.74 Median:25444.21 stddev:23024.82 (90.5%) stddev-sans-first:23054.00 07:46:38 INFO - PROCESS | 6083 | Values: 729.2 733.9 737.0 791.1 821.9 14191.4 15099.1 15116.8 15269.1 15275.4 13986.4 14155.5 14176.7 14194.5 14199.9 653.1 672.1 780.9 797.0 805.5 791.0 803.6 804.0 804.5 804.6 849.1 849.2 849.9 850.2 850.5 688.4 696.9 824.8 846.1 846.1 625.1 627.1 627.1 627.5 627.8 13732.4 13860.4 13891.4 13913.2 13981.3 13893.3 13934.8 13962.4 14070.9 14199.6 12239.3 12416.4 12421.3 12817.0 12818.0 4355.8 4402.1 4434.0 4593.6 4599.2 68589.3 69668.0 70989.0 71843.3 72318.6 10949.3 11054.3 11135.2 11355.1 11440.3 19901.2 19933.0 19976.5 19977.3 20084.6 8267.7 8368.6 8407.4 8485.4 8695.2 4412.7 4701.1 4778.1 4856.8 4886.2 3241.6 3304.0 3337.8 3338.2 3341.8 554.0 554.1 555.1 570.0 573.6 643.7 671.7 692.1 694.6 705.5 9066.7 9182.4 9222.7 9420.0 9448.1 521.1 569.6 634.5 687.3 708.0 4128.5 4357.8 4415.2 4457.6 4501.3 61720.7 68874.0 86718.6 93272.5 93719.0 70138.6 71852.0 73144.3 73892.6 74704.6 65820.7 66293.0 67987.7 68300.3 69618.3 8957.1 9203.0 9213.7 9249.9 9302.4 44991.0 45186.0 45562.3 45709.8 46187.3 55370.0 59611.4 60408.7 62127.7 65629.7 12405.6 12470.5 12500.9 12579.4 12937.8 14310.4 14337.6 14611.3 14663.3 14675.7 13028.8 13063.2 13486.9 13775.9 14253.6 12475.6 12708.8 12748.0 13033.5 13201.9 12721.9 12890.4 12914.8 13165.0 13167.5 10912.2 10918.3 11594.9 12157.6 12169.5 11201.9 11297.7 11374.5 11514.5 11667.9 07:46:38 INFO - PROCESS | 6083 | -------- Summary: end -------- 07:46:38 INFO - PROCESS | 6083 | 07:46:39 INFO - TEST-INFO | 6083: exit 0 07:46:39 INFO - TEST-OK | dromaeo_css | took 1116305ms 07:46:39 INFO - TEST-START | kraken 07:46:39 INFO - operating with platform_type : linux_ 07:46:39 INFO - Initialising browser for kraken test... 07:46:39 INFO - TEST-INFO | started process 6395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVLn71/profile http://localhost:55012/getInfo.html) 07:46:43 INFO - PROCESS | 6395 | __metrics Screen width/height:1600/1200 07:46:43 INFO - PROCESS | 6395 | colorDepth:24 07:46:43 INFO - PROCESS | 6395 | Browser inner width/height: 1024/697 07:46:43 INFO - PROCESS | 6395 | __metrics 07:46:43 INFO - PROCESS | 6395 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:46:43 INFO - PROCESS | 6395 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:46:44 INFO - PROCESS | 6395 | console.error: PushService: 07:46:44 INFO - PROCESS | 6395 | stateChangeProcessEnqueue: Error transitioning state 07:46:44 INFO - PROCESS | 6395 | UnknownError 07:46:44 INFO - TEST-INFO | 6395: exit 0 07:46:44 INFO - Browser initialized. 07:46:44 INFO - Running cycle 1/1 for kraken test... 07:46:44 INFO - TEST-INFO | started process 6480 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVLn71/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:46:57 INFO - PROCESS | 6480 | RSS: Main: 174567424 07:46:57 INFO - PROCESS | 6480 | 07:46:59 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55012/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:00 INFO - PROCESS | 6480 | RSS: Main: 239435776 07:47:00 INFO - PROCESS | 6480 | 07:47:03 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55012/tests/kraken/driver.html?testName=audio-dft) 07:47:03 INFO - PROCESS | 6480 | RSS: Main: 218251264 07:47:03 INFO - PROCESS | 6480 | 07:47:06 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55012/tests/kraken/driver.html?testName=audio-fft) 07:47:07 INFO - PROCESS | 6480 | RSS: Main: 300093440 07:47:07 INFO - PROCESS | 6480 | 07:47:09 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55012/tests/kraken/driver.html?testName=audio-oscillator) 07:47:10 INFO - PROCESS | 6480 | RSS: Main: 208359424 07:47:10 INFO - PROCESS | 6480 | 07:47:12 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:12 INFO - PROCESS | 6480 | RSS: Main: 213897216 07:47:12 INFO - PROCESS | 6480 | 07:47:15 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55012/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:16 INFO - PROCESS | 6480 | RSS: Main: 250478592 07:47:16 INFO - PROCESS | 6480 | 07:47:19 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55012/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:20 INFO - PROCESS | 6480 | RSS: Main: 249131008 07:47:20 INFO - PROCESS | 6480 | 07:47:23 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55012/tests/kraken/driver.html?testName=json-parse-financial) 07:47:23 INFO - PROCESS | 6480 | RSS: Main: 248254464 07:47:23 INFO - PROCESS | 6480 | 07:47:25 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:25 INFO - PROCESS | 6480 | RSS: Main: 210952192 07:47:25 INFO - PROCESS | 6480 | 07:47:27 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:28 INFO - PROCESS | 6480 | RSS: Main: 218480640 07:47:28 INFO - PROCESS | 6480 | 07:47:30 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:30 INFO - PROCESS | 6480 | RSS: Main: 227909632 07:47:30 INFO - PROCESS | 6480 | 07:47:33 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:34 INFO - PROCESS | 6480 | RSS: Main: 237162496 07:47:34 INFO - PROCESS | 6480 | 07:47:36 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:37 INFO - PROCESS | 6480 | RSS: Main: 233902080 07:47:37 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | Cycle 1(1): loaded http://localhost:55012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55012/tests/kraken/driver.html?testName=ai-astar) 07:47:39 INFO - PROCESS | 6480 | RSS: Main: 283529216 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | __start_tp_report 07:47:39 INFO - PROCESS | 6480 | _x_x_mozilla_page_load 07:47:39 INFO - PROCESS | 6480 | _x_x_mozilla_page_load_details 07:47:39 INFO - PROCESS | 6480 | |i|pagename|runs| 07:47:39 INFO - PROCESS | 6480 | |0;ai-astar;105;112;111;111;111;110;113;113;113;111 07:47:39 INFO - PROCESS | 6480 | |1;audio-beat-detection;152;122;124;166;129;124;124;123;159;123 07:47:39 INFO - PROCESS | 6480 | |2;audio-dft;161;161;160;160;160;162;161;161;161;160 07:47:39 INFO - PROCESS | 6480 | |3;audio-fft;75;76;75;108;76;75;76;77;118;75 07:47:39 INFO - PROCESS | 6480 | |4;audio-oscillator;82;82;114;83;83;84;104;83;83;114 07:47:39 INFO - PROCESS | 6480 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;117 07:47:39 INFO - PROCESS | 6480 | |6;imaging-darkroom;146;146;145;146;147;147;147;147;147;148 07:47:39 INFO - PROCESS | 6480 | |7;imaging-desaturate;84;84;85;84;84;85;84;85;84;85 07:47:39 INFO - PROCESS | 6480 | |8;json-parse-financial;52;53;53;52;54;55;54;53;53;54 07:47:39 INFO - PROCESS | 6480 | |9;json-stringify-tinderbox;60;61;61;60;60;61;61;62;66;61 07:47:39 INFO - PROCESS | 6480 | |10;stanford-crypto-aes;83;86;79;79;80;87;80;79;88;79 07:47:39 INFO - PROCESS | 6480 | |11;stanford-crypto-ccm;145;134;137;130;132;130;140;133;168;136 07:47:39 INFO - PROCESS | 6480 | |12;stanford-crypto-pbkdf2;168;167;166;164;168;166;174;170;170;166 07:47:39 INFO - PROCESS | 6480 | |13;stanford-crypto-sha256-iterative;65;71;68;63;64;64;67;68;67;64 07:47:39 INFO - PROCESS | 6480 | __end_tp_report 07:47:39 INFO - PROCESS | 6480 | __start_cc_report 07:47:39 INFO - PROCESS | 6480 | _x_x_mozilla_cycle_collect,1686 07:47:39 INFO - PROCESS | 6480 | __end_cc_report 07:47:39 INFO - PROCESS | 6480 | __startTimestamp1477925259473__endTimestamp 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | ------- Summary: start ------- 07:47:39 INFO - PROCESS | 6480 | Number of tests: 14 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:2.36 (2.1%) stddev-sans-first:1.12 07:47:39 INFO - PROCESS | 6480 | Values: 105.0 112.0 111.0 111.0 111.0 110.0 113.0 113.0 113.0 111.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:126.50 stddev:17.26 (13.6%) stddev-sans-first:17.12 07:47:39 INFO - PROCESS | 6480 | Values: 152.0 122.0 124.0 166.0 129.0 124.0 124.0 123.0 159.0 123.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:47:39 INFO - PROCESS | 6480 | Values: 161.0 161.0 160.0 160.0 160.0 162.0 161.0 161.0 161.0 160.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.50 stddev:15.95 (21.1%) stddev-sans-first:16.64 07:47:39 INFO - PROCESS | 6480 | Values: 75.0 76.0 75.0 108.0 76.0 75.0 76.0 77.0 118.0 75.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:13.72 (16.5%) stddev-sans-first:14.14 07:47:39 INFO - PROCESS | 6480 | Values: 82.0 82.0 114.0 83.0 83.0 84.0 104.0 83.0 83.0 114.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:47:39 INFO - PROCESS | 6480 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 07:47:39 INFO - PROCESS | 6480 | Values: 146.0 146.0 145.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 07:47:39 INFO - PROCESS | 6480 | Values: 84.0 84.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 85.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:0.95 (1.8%) stddev-sans-first:0.88 07:47:39 INFO - PROCESS | 6480 | Values: 52.0 53.0 53.0 52.0 54.0 55.0 54.0 53.0 53.0 54.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:1.77 (2.9%) stddev-sans-first:1.81 07:47:39 INFO - PROCESS | 6480 | Values: 60.0 61.0 61.0 60.0 60.0 61.0 61.0 62.0 66.0 61.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.68 (4.5%) stddev-sans-first:3.89 07:47:39 INFO - PROCESS | 6480 | Values: 83.0 86.0 79.0 79.0 80.0 87.0 80.0 79.0 88.0 79.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:136.50 stddev:11.36 (8.3%) stddev-sans-first:11.80 07:47:39 INFO - PROCESS | 6480 | Values: 145.0 134.0 137.0 130.0 132.0 130.0 140.0 133.0 168.0 136.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:2.85 (1.7%) stddev-sans-first:3.02 07:47:39 INFO - PROCESS | 6480 | Values: 168.0 167.0 166.0 164.0 168.0 166.0 174.0 170.0 170.0 166.0 07:47:39 INFO - PROCESS | 6480 | 07:47:39 INFO - PROCESS | 6480 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:2.51 (3.8%) stddev-sans-first:2.64 07:47:39 INFO - PROCESS | 6480 | Values: 65.0 71.0 68.0 63.0 64.0 64.0 67.0 68.0 67.0 64.0 07:47:39 INFO - PROCESS | 6480 | -------- Summary: end -------- 07:47:39 INFO - PROCESS | 6480 | 07:47:40 INFO - TEST-INFO | 6480: exit 0 07:47:40 INFO - TEST-OK | kraken | took 61172ms 07:47:40 INFO - SUITE-END | took 1177s 07:47:41 INFO - Completed test suite (00:19:37) 07:47:41 INFO - javascript benchmark 07:47:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2934.853257337133, 2958.3433277364666, 2966.8961586344476, 2979.851007449627, 3001.0696684027953, 4884.53596908294, 4997.80008799648, 5042.1428357179275, 5085.4151772546165, 5134.358205224347, 5050.545450909417, 5069.79720811168, 5135.178371460567, 5146.639735218536, 5170.9482905170935, 4576.679632425723, 4603.654725895554, 4642.628589712832, 4655.4878963314, 4673.485916549177, 4127.938080928789, 4613.8154473821005, 4690.7654617269, 4702.200625893606, 4702.647301452388, 4468.776561171929, 4698.718076915396, 4711.0342379812055, 4739.194336962707, 4818.542238487338, 4517.706349087332, 4598.0344127733215, 4608.792604332813, 4671.392718946549, 4672.57946784791, 4623.0, 4623.006053698437, 4639.953600463986, 4684.414448193976, 4699.78850951708, 5047.798088076473, 5080.5173508517, 5104.872378190538, 5109.978004399098, 5156.407013193456, 5218.452062533417, 5258.474152584749, 5263.210518422229, 5334.759935802898, 5416.052190866582, 5340.198970154469, 5342.332208473941, 5350.143976963706, 5358.812441564565, 5364.034473794715, 4964.60283177345, 5021.899562008739, 5022.347094877642, 5024.522670346311, 5027.421846487628, 5397.8110766123, 5477.7261136943, 5579.38626751057, 5590.105583106683, 5594.692291923902, 5267.815626453055, 5306.787728490895, 5314.229436731653, 5317.973410132925, 5362.034833729966, 5377.569794416438, 5386.649867758583, 5389.51494365509, 5395.568354531628, 5452.836414907559, 5164.948350516522, 5214.478552144831, 5341.759620817073, 5355.919661205085, 5416.160495123262, 5434.592405569519, 5440.483154100354, 5449.754761035683, 5494.80768173112, 5507.421720719347, 4213.6839737019845, 4216.578342165821, 4217.704760666786, 4227.450431443893, 4273.444452221192, 3667.651573100551, 3691.2617476504806, 3768.8492460301827, 3810.7713537187856, 3822.904427389282, 5037.697738135724, 5106.591472682177, 5108.412532558729, 5117.616178786606, 5196.324477817935, 5423.430539793344, 5430.940966511493, 5433.347998240237, 5444.727763611803, 5446.0, 5096.261042148868, 5102.4897510248675, 5124.871878203075, 5127.66670166438, 5166.940777140677, 4534.274516077412, 4577.656675749266, 4657.767111644404, 4702.083093796677, 4704.223803072523, 5552.3892371839065, 5555.583331250173, 5559.11054231321, 5559.471850174227, 5604.775808967595, 5400.297961265011, 5440.782368705208, 5454.236406902957, 5458.754356054066, 5519.420460851553, 5237.502437268454, 5302.973485132549, 5582.218489411404, 5584.106542953108, 5635.436456354331, 5365.758540865749, 5367.51692347675, 5372.221027951004, 5433.918491222714, 5434.184872269191, 5374.973125134349, 5431.755570999394, 5439.3200849893765, 5444.50999410055, 5509.256250406143, 5068.138416469283, 5123.180291153398, 5276.920846187387, 5302.840914772563, 5321.3348331458565, 5296.205569164502, 5349.1976203569775, 5349.598780091431, 5390.460953904578, 5406.864828379322, 5275.366955965309, 5321.467853214647, 5329.467053294795, 5341.893162136657, 5385.838424847261, 5126.307948426915, 5173.4826517347965, 5380.246765452762, 5380.273663055594, 5389.7035663038905, 5132.5893928486375, 5169.586433085419, 5173.741312934413, 5175.689458632494, 5230.032443997872], "value": 4995.139444679631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5948776368778, 577.4312302382153, 581.3082431906034, 583.1049339264229, 602.9547783916207, 31175.53236701451, 41960.0, 43296.134077318435, 43344.78327608362, 47268.29097563539, 44606.0, 44906.10187796242, 44966.55033449664, 44971.77514112425, 45059.324110138296, 8736.650533978649, 8879.28965682747, 8885.555722213896, 8891.110888911122, 8893.377463577552, 7922.524648521107, 8128.796780080486, 10321.225908056887, 10567.841482377771, 10590.046895779378, 10794.352338859655, 10842.457877106153, 10848.0, 10851.51168197433, 10853.0, 10521.210909181842, 10605.628802991936, 10612.681619551426, 10666.093382062534, 10682.03861652455, 10468.47657617116, 10574.682759517227, 10601.0, 10609.522571484302, 10614.628488002883, 41299.58700412988, 41675.0, 41690.79154604208, 41719.0, 41735.79132104351, 3277.918052048694, 3505.7545971781988, 3666.468362087509, 3992.7604343739467, 3994.0613955720382, 30789.230269243224, 31934.20164495883, 31989.0, 32014.199645009063, 32093.679063209303, 4326.870193894157, 4395.7362558246605, 4415.845445409395, 4599.977000114978, 4604.470485894131, 329368.0, 330587.0, 331388.0, 332448.0, 334715.0, 55217.0, 55790.16314755282, 55875.441245587026, 55887.44112558904, 55985.44014559884, 58617.41382586205, 58647.0, 58706.41293587095, 58735.41264587385, 58836.0, 15521.767173492406, 15673.608159796097, 15678.529644110695, 15678.843211567966, 15684.058956462648, 11663.533458661559, 11702.590409335633, 11714.121440891968, 11757.0, 11910.225835320676, 14369.13785172893, 14383.424663013362, 14425.826318209976, 15177.24113794306, 15663.216839157996, 5348.277982472394, 6023.427774361428, 6055.8486037848525, 6156.138140660311, 6202.968985155136, 963.3545524498603, 1012.5342342522522, 1018.4805749068029, 1028.3675539543126, 1048.3290693955873, 31071.373454869783, 31284.687153128634, 31439.84280078585, 31634.36731265362, 32095.679043209268, 1066.7173199102244, 1069.8662667166604, 1072.254782925859, 1086.4839201379282, 1125.2011072138873, 16386.590335241475, 16393.344266229455, 16400.671986560203, 16430.424935127212, 16723.581910452336, 480313.0, 484794.0, 485672.0, 504798.0, 740893.0, 49162.26256606154, 50049.99600031989, 58125.0, 59092.40907590869, 59742.0, 1346.898982576291, 1360.8366995960548, 1372.9176249425066, 1376.0298989212781, 1382.7969666390304, 30107.0, 32112.0, 32857.671423285465, 32872.0, 34919.65080349164, 54008.72995634997, 54642.180367293724, 54690.0, 54691.0, 54703.17945230745, 356752.0, 357751.0, 358147.0, 358416.0, 358494.0, 26807.329816754736, 27244.455110898067, 27256.863715681295, 27281.181564553095, 27302.590461142703, 45958.080838383714, 46063.76968115138, 46096.07807843891, 46111.53888461072, 47535.28697069616, 39354.409683854195, 39654.80172599119, 39795.0, 40053.799731001156, 41594.58405416028, 38817.22365552617, 39666.60333396745, 39764.80117599393, 39912.40131397973, 40629.1874162521, 39785.60214397935, 40259.39610905897, 40481.59518404896, 40677.0, 41251.79374103231, 33831.49252761161, 36278.637213627524, 36981.63018369889, 37024.444633329986, 37131.814340928126, 27061.188164354313, 27259.318517037234, 27306.317342066606, 27409.314767130185, 27497.45005099847], "value": 19833.84417781173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.97959612221354, 375.92105657811857, 377.3076404797197, 383.601054902901, 386.1273521840641, 14146.0, 17979.910100449495, 18578.814211857876, 18652.160652770624, 19778.208871645118, 17919.552011199725, 17924.731129033044, 18093.27626894926, 18185.727214091767, 18341.0, 5622.634528755638, 5930.021546444831, 5936.0, 5942.732577034044, 5946.910796338058, 4170.436991006206, 4330.220560299145, 4338.631216346615, 5768.163616275638, 5881.117832325164, 6570.0, 6578.407943285103, 6692.196936367618, 6698.196216454008, 6708.932910670904, 6402.455791257748, 6468.353164683517, 6495.382938620824, 6502.577332473422, 6683.498737594676, 5621.7236838836225, 5670.773169073233, 5675.404082571353, 5680.886382272372, 5684.8010319638615, 21141.471463213387, 21976.0, 23068.307950761337, 23348.533029339316, 23486.530269394687, 2271.965920511194, 2293.3578597992587, 2340.871252081135, 2505.235903049569, 2909.806979138564, 9295.442273463546, 9877.555510002067, 10388.117010054155, 10765.354078755221, 11298.943505282503, 1903.486058764126, 1930.1989674285155, 1951.980480195194, 1968.4488343263909, 1987.920483180671, 78811.6059419705, 80134.59932700357, 85594.57202713947, 85828.14171858264, 86528.0, 10431.530581123867, 10536.420496872746, 10753.623623173307, 10864.402457864735, 10926.125909927187, 15037.172955487553, 15125.848741512664, 15154.545363639108, 15156.696866062617, 15158.848411515964, 7780.766577002699, 8002.439829211899, 8131.390145739093, 8290.875636865452, 8302.252797248277, 7691.461597688108, 7718.498297610638, 7770.41721870862, 7939.444238903337, 8004.79988000293, 4559.635229181657, 4576.153411618861, 4580.88547786308, 4593.839215627504, 4615.284630882152, 1823.881447705895, 1887.169645356039, 1894.3748562974185, 1906.8855868647925, 1917.6931690929664, 880.9163129502687, 1014.878214614251, 1058.2750815691277, 1058.539535302146, 1064.6486659402533, 18975.81024189768, 19665.606687866162, 19764.0, 19800.405987820388, 19944.20223191056, 975.3075316525204, 993.0813997052697, 1006.7533454303742, 1037.6562351754496, 1037.9377237365782, 10449.268551201494, 10733.302335348177, 10826.404547749791, 10857.13142948578, 10867.728306792393, 445148.0, 450412.0, 453844.0, 468367.0, 470807.0, 52470.21294680583, 62503.0, 85060.57469712613, 88823.55588222017, 89963.55018224867, 947.36999895069, 980.9607615695435, 1008.7679833638158, 1013.2046343620223, 1015.3653966271081, 16414.67170656556, 17121.400750973655, 17265.82734172642, 17307.2211750469, 17441.38955136615, 40693.79653101716, 40953.0, 41278.587214127474, 41615.1676966465, 41700.0, 54136.0, 54678.453215467336, 55654.72172639111, 57077.71461142668, 57325.0, 7004.509684322048, 7468.290512401313, 8328.750137495885, 8460.196281353261, 8784.604692788713, 12477.75044499123, 12500.499980000699, 12913.0, 13018.15382000167, 13400.396982135633, 10809.405482698527, 11467.885321146681, 11579.594714184963, 11589.82615260755, 11778.175527712978, 11046.171537134907, 11562.421878906189, 11733.941330293294, 11739.06087513014, 11858.407079646156, 11722.472488737856, 11823.645290641294, 11860.288382697066, 12072.456739446921, 12375.381230938598, 7223.0, 7664.118626357817, 7724.266194711493, 7881.448298619041, 8075.5558444286125, 9078.001419843944, 11464.426778660867, 11521.596744113916, 11756.23584467007, 11800.940995294968], "value": 9068.648426489317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.1870812034367, 1381.2748307138754, 1420.2614640386998, 1528.4268399350244, 1702.1319127245108, 6974.16310042795, 7715.421343399246, 7931.643076061577, 7938.9603051984805, 8106.148854370294, 7999.240072193147, 8068.556229407381, 8074.111847696749, 8075.353971682266, 8080.959595202015, 2224.154821167958, 2244.1023590563823, 2244.9438764030865, 2246.640537513998, 2255.3008567344095, 2147.3128598848375, 2206.172685243034, 2226.031676220841, 2227.8106360959337, 2235.3852690510157, 2192.27654873892, 2194.561087782442, 2214.0, 2224.2659922225625, 2235.418791114314, 2152.2897443843494, 2156.4716644422138, 2173.6848157017225, 2173.8586991845636, 2174.0325555127974, 2157.2126173946554, 2176.651735722277, 2179.063002908749, 2179.302623160589, 2182.5962196993605, 7782.416318776114, 7895.802604934923, 7961.840763184704, 7962.203779621991, 7975.082865470487, 4916.8770780730765, 5117.795288188468, 5130.102232109366, 5136.0, 5139.383274007106, 3245.2049247934406, 3326.168457885529, 3373.443381841993, 3419.9658003419895, 3422.8973130805866, 1134.1720544002842, 1135.6422726841101, 2079.8232150267245, 2102.8107470327745, 2179.2154824263253, 10973.890261097367, 10999.780004399867, 11038.0, 11068.39123848188, 11072.058874995635, 4067.633912947849, 4245.27830268855, 4311.353297005474, 4348.847790327387, 4355.194289056535, 8660.8700869487, 8668.78328041804, 8669.959604847332, 8672.176143266379, 8673.176048275403, 4929.137400954819, 4958.057968985953, 4961.131801934647, 4964.826231081895, 4966.1309270877455, 3865.4974853268895, 4068.4304197412384, 4142.979285103555, 4610.124076425468, 4662.230731929194, 3443.362977849056, 3468.514407982884, 3522.18989632386, 3531.134871956387, 3538.7876727396438, 1061.7186445591924, 1063.9361638301573, 1079.228351728518, 1079.740862193068, 1081.0702795595782, 802.173761026144, 814.3159745813426, 837.7046495585679, 876.8860048193694, 915.2037727177399, 5035.697858128524, 5236.711980841014, 5295.920561191585, 5436.565074794007, 5438.972805135949, 403.6871424645923, 408.7547471517066, 424.79185199252146, 445.72587858466807, 450.9481409637868, 3445.793252404864, 3493.4934434507363, 3540.2565461253425, 3588.9282214355567, 3656.689181419609, 9481.0, 9785.266105042008, 9886.060824221688, 9889.80220395588, 9908.80182396348, 9745.0, 9794.0, 9801.411915285105, 9847.556859941176, 9862.112409883002, 7208.243134470805, 7516.872469129675, 7663.655135518915, 7664.386849052063, 7668.80827979305, 5060.291559181644, 5387.973060134675, 5421.810236641699, 5503.394626591152, 5684.772609095755, 8935.463872167691, 8950.731478055668, 8964.103589641245, 8978.506182160045, 9044.547772611211, 8358.498490090615, 9018.639254429749, 9342.579583918876, 9376.67181648639, 9502.334836561375, 6735.360140786617, 6901.413379862567, 7007.509474336747, 7099.538529995741, 7212.062431883822, 7628.618569071636, 7698.769036928901, 7715.074191097105, 7745.961270193839, 7779.0, 6986.895196572157, 6994.33553812387, 7026.156861176692, 7042.0493233412835, 7047.541909775849, 6755.42578880781, 6775.390214880685, 6817.147856517935, 6822.522423430511, 6856.725730970905, 6097.420745029215, 6182.381761823782, 6192.876142477216, 6197.566170368031, 6204.720787564661, 4606.976965115153, 4734.55021772931, 4748.311494833299, 4777.474477807508, 4831.782569784298, 4636.65225108125, 4742.691725037862, 4747.881302967316, 4899.608031357411, 4935.851924442272], "value": 4203.478519682906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.36327842346634, 333.8214055480317, 335.19720269953467, 338.59199664404395, 340.7069919868914, 5282.392524859638, 5329.840104796862, 5341.252224688542, 5347.679139251648, 5359.866003349914, 5244.187150991593, 5259.474052594738, 5268.209768534722, 5271.894562108756, 5277.1556550951855, 3947.467091942594, 4012.498437695288, 4038.9394159087637, 4083.2650122977852, 4122.0, 4101.651359634435, 4107.650849677781, 4121.670266378697, 4127.525334586531, 4146.502419709639, 4076.6331030207275, 4085.836566537335, 4092.1611069730784, 4093.8362465501345, 4102.2104968621325, 3696.445533170019, 3873.7288389812725, 3943.605639436062, 4095.242380159665, 4111.629953304187, 3598.1544337080763, 3611.368010598135, 3629.6007439181667, 3646.762960407565, 3648.5986541480415, 5080.0, 5090.643654944155, 5094.821681241138, 5103.2855400244, 5153.716545589991, 4543.273076307775, 4717.315989181584, 4718.952810471886, 4730.929036064462, 4741.739204343759, 5492.615516913817, 5500.312460942382, 5514.766519559585, 5515.4760297771645, 5515.917261241085, 4024.8993775155564, 4035.1324465239823, 4037.315185401704, 4040.272750904836, 4045.4538637284177, 5482.451754824526, 5736.397678243808, 5759.667334729441, 5774.364819869811, 5775.249217601685, 4025.255327764314, 4037.4549435826375, 4041.333180025263, 4045.110075783323, 4046.959530404717, 4087.9371363445125, 4091.3453847384276, 4093.3041382964966, 4096.774677392712, 4106.2198182345255, 4508.301213311942, 4619.145458090264, 4682.438107427062, 4688.671792974527, 4696.2486002239475, 5504.651360416643, 5510.913888222528, 5513.393526712059, 5530.6128570999645, 5530.917036244459, 1395.7417877692455, 1410.6261840612246, 1413.2439145057344, 1416.3272445588264, 1422.7936949142315, 904.3669431398048, 913.9177474027236, 913.949732764691, 919.296737995434, 923.3721069672687, 5232.712200828915, 5269.366496386133, 5276.683398996072, 5281.656692314988, 5289.545375021899, 5619.943800562024, 5647.915281270784, 5652.519535839418, 5686.943130568724, 5691.743871525791, 5159.664621799571, 5325.440828713007, 5379.193121031876, 5381.973090134525, 5386.461353864583, 2994.595729576523, 3004.969950300469, 3005.7294843463756, 3012.322227498795, 3019.667836537979, 5787.643166963151, 5796.971015144897, 5812.505936995402, 5824.504917082096, 5839.678817664984, 5525.502704756511, 5777.7977770777825, 5811.4479124483105, 5816.680082595498, 5849.356570777211, 5845.590808643354, 5852.209951656557, 5871.4128587141795, 5877.4122587740885, 5879.647221166743, 5583.246261754611, 5716.199732037435, 5731.340895797037, 5749.770009199752, 5760.366359700513, 5575.386707462257, 5593.9440605595055, 5616.831495055155, 5663.7451314690115, 5666.490015898589, 5731.283589551306, 5873.238028591491, 5894.145348924468, 5896.852578685567, 5903.911441328298, 4038.1519880825354, 4072.045418199222, 4075.449814275035, 4077.388391741144, 4093.5263305210697, 5658.236138121466, 5663.575231857545, 5695.886082278248, 5699.974004679032, 5732.598718089694, 5295.4439783822145, 5500.394956554695, 5542.889142217214, 5568.6658800472105, 5585.3297604287745, 5514.5864060194845, 5540.196671482693, 5540.445955404427, 5554.666719996813, 5559.444055594408, 5487.5884308677805, 5504.697241651587, 5530.419305972976, 5538.750756215899, 5544.500994910478, 5371.758270877898, 5468.371137319259, 5501.642393244426, 5531.640443371168, 5533.446655334435, 5386.8383948481605, 5402.054640437829, 5406.783473718382, 5414.485623865727, 5445.482679145475], "value": 4215.145072428593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2088084428395, 733.9449541284405, 736.9852602947941, 791.1020991175022, 821.9136990615985, 14191.432342706292, 15099.094054356747, 15116.848831511708, 15269.08385496871, 15275.388984440622, 13986.440542378292, 14155.504557340495, 14176.716465670681, 14194.503192388269, 14199.858001419983, 653.1182903080827, 672.1161672400801, 780.8945792318021, 796.976090717278, 805.4965646470955, 790.9644066017014, 803.6142651527271, 803.9879401808948, 804.4690504267185, 804.5534728225832, 849.0787495567317, 849.1932663969254, 849.8937632795901, 850.2262940723942, 850.5067061104545, 688.3838964127078, 696.8606278744221, 824.826786374862, 846.124261389462, 846.1411667157839, 625.1185827982523, 627.0969803483016, 627.1314229791726, 627.4760574919902, 627.7865525721277, 13732.382042808098, 13860.4455821767, 13891.4443422264, 13913.234772087531, 13981.300934953313, 13893.305334733222, 13934.790978135336, 13962.441502339894, 14070.92964535181, 14199.574012779633, 12239.32683702396, 12416.379181040911, 12421.254724716546, 12817.03872209588, 12818.0, 4355.84754533593, 4402.119576084796, 4434.0, 4593.609543188833, 4599.195140850371, 68589.31410685879, 69667.95498067584, 70989.0, 71843.28156718418, 72318.63840680815, 10949.288296260718, 11054.336739795637, 11135.164862635334, 11355.148363872577, 11440.256383335056, 19901.203951841766, 19933.0, 19976.500587485138, 19977.300794472125, 20084.598308033757, 8267.669293228324, 8368.623411946477, 8407.369447291478, 8485.448445851123, 8695.217430431292, 4412.69111162222, 4701.106789709944, 4778.068276686013, 4856.80572777092, 4886.169351210303, 3241.578594782663, 3304.0, 3337.7997320160866, 3338.165458635341, 3341.799492030486, 553.9806106786243, 554.1217170784272, 555.084111216496, 569.9601027928088, 573.5984810632574, 643.7264162730914, 671.6767967104796, 692.1486571516962, 694.6144889586328, 705.4744215559441, 9066.682666106655, 9182.403143795633, 9222.677206297882, 9420.0, 9448.102430269113, 521.0802932823569, 569.5671289819767, 634.501915995941, 687.3126873126873, 708.0476758759461, 4128.545859955402, 4357.8256869724855, 4415.183191109655, 4457.551295828868, 4501.29147625668, 61720.69139654273, 68874.0, 86718.56640716882, 93272.53363733138, 93719.0, 70138.64930675314, 71852.0, 73144.26855731374, 73892.63053684805, 74704.62647686836, 65820.67089664521, 66293.0, 67987.66006170037, 68300.31699683038, 69618.30381696118, 8957.14907083826, 9203.0, 9213.723588292361, 9249.861252081359, 9302.441853488812, 44991.0, 45185.99999999868, 45562.31656525088, 45709.77145114386, 46187.30719039284, 55370.0, 59611.40388596232, 60408.69795650994, 62127.689361552904, 65629.67185164044, 12405.62783116508, 12470.5011799527, 12500.93637167193, 12579.371031448574, 12937.805932911202, 14310.356033978704, 14337.56987290383, 14611.269436527919, 14663.340149693076, 14675.706485870436, 13028.804567931678, 13063.216207027608, 13486.881276545057, 13775.862241377457, 14253.572392828231, 12475.625731228078, 12708.759266387013, 12747.973947198403, 13033.543825966046, 13201.867981320449, 12721.93639031799, 12890.41993110331, 12914.80627790565, 13165.0, 13167.47330106785, 10912.236143469881, 10918.290311129751, 11594.884051159717, 12157.635270941886, 12169.513219471122, 11201.88798112041, 11297.661070167907, 11374.545018199511, 11514.539418423505, 11667.883321166679], "value": 7119.057342506609, "unit": "score"}], "name": "dromaeo_css", "value": 6956.621974048727, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 111.0, 111.0, 110.0, 113.0, 113.0, 113.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 124.0, 166.0, 129.0, 124.0, 124.0, 123.0, 159.0, 123.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 108.0, 76.0, 75.0, 76.0, 77.0, 118.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 114.0, 83.0, 83.0, 84.0, 104.0, 83.0, 83.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 54.0, 55.0, 54.0, 53.0, 53.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 62.0, 66.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 79.0, 79.0, 80.0, 87.0, 80.0, 79.0, 88.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 137.0, 130.0, 132.0, 130.0, 140.0, 133.0, 168.0, 136.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 166.0, 164.0, 168.0, 166.0, 174.0, 170.0, 170.0, 166.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 68.0, 63.0, 64.0, 64.0, 67.0, 68.0, 67.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1497.4, "alertThreshold": 2.0}]} 07:47:41 INFO - Return code: 0 07:47:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:47:41 INFO - # TBPL SUCCESS # 07:47:41 INFO - Running post-action listener: _resource_record_post_action 07:47:41 INFO - [mozharness: 2016-10-31 14:47:41.295151Z] Finished run-tests step (success) 07:47:41 INFO - Running post-run listener: _resource_record_post_run 07:47:41 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409706496; Read time: 12; Write time: 309620 07:47:41 INFO - TinderboxPrint: CPU usage
13.0% 07:47:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:47:41 INFO - TinderboxPrint: I/O write bytes / time
409,706,496 / 309,620 07:47:41 INFO - TinderboxPrint: CPU idle
8,290.7 (86.9%) 07:47:41 INFO - TinderboxPrint: CPU user
1,195.7 (12.5%) 07:47:41 INFO - TinderboxPrint: Swap in / out
0 / 0 07:47:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120152064; Read time: 0; Write time: 91496 07:47:41 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289554432; Read time: 0; Write time: 218124 07:47:41 INFO - Running post-run listener: _upload_blobber_files 07:47:41 INFO - Blob upload gear active. 07:47:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:47:41 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 07:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:47:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:47:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:47:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:44 INFO - (blobuploader) - INFO - Done attempting. 07:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:45 INFO - (blobuploader) - INFO - Done attempting. 07:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:48 INFO - (blobuploader) - INFO - Done attempting. 07:47:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:47:48 INFO - Return code: 0 07:47:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:47:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:47:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2baa6f8cb1783ff658d0508489340b7f9b8aa6646ca80d6b06c711ed3dbb09cc845a673ac812eff4f846fe2a2fd589f2e755f0f42b786eefaa05f609c399c2bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0060ac3efbacd3e2652c9b5c0cc621292c39c29a578f8ce9c09e89239c8b8cfcf9bf79f512a8ef0f0a5d1177f4fa4874daa9dc13e816b2cbf3ff7a228f95df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d87d1606caefba06b5dc305d99550a8e0918faaf20c774df15f2875b647d3bc6fa02d69e85e3850bf8f56dc3c497ac92931d187528b4bc2bc5e04cc5fb9161a"} 07:47:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:47:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:47:48 INFO - Contents: 07:47:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2baa6f8cb1783ff658d0508489340b7f9b8aa6646ca80d6b06c711ed3dbb09cc845a673ac812eff4f846fe2a2fd589f2e755f0f42b786eefaa05f609c399c2bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0060ac3efbacd3e2652c9b5c0cc621292c39c29a578f8ce9c09e89239c8b8cfcf9bf79f512a8ef0f0a5d1177f4fa4874daa9dc13e816b2cbf3ff7a228f95df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d87d1606caefba06b5dc305d99550a8e0918faaf20c774df15f2875b647d3bc6fa02d69e85e3850bf8f56dc3c497ac92931d187528b4bc2bc5e04cc5fb9161a"} 07:47:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:47:48 INFO - Copying logs to upload dir... 07:47:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:47:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.114429 ========= master_lag: 1.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-31 07:47:50.166804) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 07:47:50.171703) ========= 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=0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2baa6f8cb1783ff658d0508489340b7f9b8aa6646ca80d6b06c711ed3dbb09cc845a673ac812eff4f846fe2a2fd589f2e755f0f42b786eefaa05f609c399c2bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0060ac3efbacd3e2652c9b5c0cc621292c39c29a578f8ce9c09e89239c8b8cfcf9bf79f512a8ef0f0a5d1177f4fa4874daa9dc13e816b2cbf3ff7a228f95df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d87d1606caefba06b5dc305d99550a8e0918faaf20c774df15f2875b647d3bc6fa02d69e85e3850bf8f56dc3c497ac92931d187528b4bc2bc5e04cc5fb9161a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477758605/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2baa6f8cb1783ff658d0508489340b7f9b8aa6646ca80d6b06c711ed3dbb09cc845a673ac812eff4f846fe2a2fd589f2e755f0f42b786eefaa05f609c399c2bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0060ac3efbacd3e2652c9b5c0cc621292c39c29a578f8ce9c09e89239c8b8cfcf9bf79f512a8ef0f0a5d1177f4fa4874daa9dc13e816b2cbf3ff7a228f95df8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d87d1606caefba06b5dc305d99550a8e0918faaf20c774df15f2875b647d3bc6fa02d69e85e3850bf8f56dc3c497ac92931d187528b4bc2bc5e04cc5fb9161a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 07:47:50.203543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 07:47:50.203873) ========= 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=0333a256a5e4f052382dd180000001b1-1477924019.331651-320406198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 07:47:50.253037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 07:47:50.253347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 07:47:50.253627) ========= ========= Total master_lag: 1.77 =========